builder: cedar_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0089 starttime: 1480445544.56 results: success (0) buildid: 20161129071027 builduid: f6b0a3d1e4c2404486ffb6ef0649a958 revision: 1ab6a9dfef56cedb1d917aac82240a3be0fb8f20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 10:52:24.560862) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 10:52:24.561350) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 10:52:24.561630) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 10:52:24.587790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:52:24.588188) ========= 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.argJvf95jl/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.GbY65q7S80/Listeners TMPDIR=/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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-11-29 10:52:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.04M=0.001s 2016-11-29 10:52:24 (8.04 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095084 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:52:24.705151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:52:24.705459) ========= 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.argJvf95jl/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.GbY65q7S80/Listeners TMPDIR=/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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.022592 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:52:24.754048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 10:52:24.754396) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 1ab6a9dfef56cedb1d917aac82240a3be0fb8f20 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 1ab6a9dfef56cedb1d917aac82240a3be0fb8f20 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.argJvf95jl/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.GbY65q7S80/Listeners TMPDIR=/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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-11-29 10:52:24,836 truncating revision to first 12 chars 2016-11-29 10:52:24,836 Setting DEBUG logging. 2016-11-29 10:52:24,836 attempt 1/10 2016-11-29 10:52:24,836 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/1ab6a9dfef56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 10:52:25,986 unpacking tar archive at: cedar-1ab6a9dfef56/testing/mozharness/ program finished with exit code 0 elapsedTime=1.418651 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 10:52:26.196903) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 10:52:26.197265) ========= script_repo_revision: 1ab6a9dfef56cedb1d917aac82240a3be0fb8f20 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 10:52:26.197701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 10:52:26.197985) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 10:52:26.218060) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-29 10:52:26.218451) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', '--add-option', '--webServer,localhost', '--branch-name', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.argJvf95jl/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.GbY65q7S80/Listeners TMPDIR=/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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:52:26 INFO - MultiFileLogger online at 20161129 10:52:26 in /builds/slave/test 10:52:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 10:52:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:52:26 INFO - {'append_to_log': False, 10:52:26 INFO - 'base_work_dir': '/builds/slave/test', 10:52:26 INFO - 'blob_upload_branch': 'Cedar', 10:52:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:52:26 INFO - 'branch': 'Cedar', 10:52:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:26 INFO - 'config_files': ('talos/mac_config.py',), 10:52:26 INFO - 'default_actions': ('clobber', 10:52:26 INFO - 'read-buildbot-config', 10:52:26 INFO - 'download-and-extract', 10:52:26 INFO - 'populate-webroot', 10:52:26 INFO - 'create-virtualenv', 10:52:26 INFO - 'install', 10:52:26 INFO - 'run-tests'), 10:52:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:26 INFO - 'download_minidump_stackwalk': True, 10:52:26 INFO - 'download_symbols': 'ondemand', 10:52:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:26 INFO - 'installer_path': 'installer.exe', 10:52:26 INFO - 'log_level': 'info', 10:52:26 INFO - 'log_name': 'talos', 10:52:26 INFO - 'log_to_console': True, 10:52:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:52:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:52:26 INFO - 'opt_config_files': (), 10:52:26 INFO - 'pip_index': False, 10:52:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:52:26 INFO - 'cmd': ('bash', 10:52:26 INFO - '-c', 10:52:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:52:26 INFO - 'enabled': True, 10:52:26 INFO - 'halt_on_failure': False, 10:52:26 INFO - 'name': 'check_screen_resolution'},), 10:52:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:52:26 INFO - 'cmd': ('bash', 10:52:26 INFO - '-c', 10:52:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:52:26 INFO - 'enabled': True, 10:52:26 INFO - 'halt_on_failure': False, 10:52:26 INFO - 'name': 'check_screen_resolution'},), 10:52:26 INFO - 'run_cmd_checks_enabled': True, 10:52:26 INFO - 'sps_profile': False, 10:52:26 INFO - 'sps_profile_interval': 0, 10:52:26 INFO - 'suite': 'dromaeojs', 10:52:26 INFO - 'system_bits': '32', 10:52:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:26 INFO - 'title': 't-yosemite-r7-0089', 10:52:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:26 INFO - 'use_talos_json': True, 10:52:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:52:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:26 INFO - 'work_dir': 'build'} 10:52:26 INFO - [mozharness: 2016-11-29 18:52:26.416185Z] Running clobber step. 10:52:26 INFO - Running pre-action listener: _resource_record_pre_action 10:52:26 INFO - Running main action method: clobber 10:52:26 INFO - rmtree: /builds/slave/test/build 10:52:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:27 INFO - Running post-action listener: _resource_record_post_action 10:52:27 INFO - [mozharness: 2016-11-29 18:52:27.646657Z] Finished clobber step (success) 10:52:27 INFO - [mozharness: 2016-11-29 18:52:27.646983Z] Running read-buildbot-config step. 10:52:27 INFO - Running pre-action listener: _resource_record_pre_action 10:52:27 INFO - Running main action method: read_buildbot_config 10:52:27 INFO - Using buildbot properties: 10:52:27 INFO - { 10:52:27 INFO - "project": "", 10:52:27 INFO - "product": "firefox", 10:52:27 INFO - "script_repo_revision": "default", 10:52:27 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs", 10:52:27 INFO - "repository": "", 10:52:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs", 10:52:27 INFO - "buildid": "20161129071027", 10:52:27 INFO - "pgo_build": "False", 10:52:27 INFO - "basedir": "/builds/slave/test", 10:52:27 INFO - "buildnumber": 0, 10:52:27 INFO - "slavename": "t-yosemite-r7-0089", 10:52:27 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:52:27 INFO - "platform": "yosemite_r7", 10:52:27 INFO - "scheduler": "tests-cedar-macosx64-talos", 10:52:27 INFO - "branch": "cedar", 10:52:27 INFO - "repo_path": "projects/cedar", 10:52:27 INFO - "revision": "1ab6a9dfef56cedb1d917aac82240a3be0fb8f20", 10:52:27 INFO - "stage_platform": "macosx64", 10:52:27 INFO - "builduid": "f6b0a3d1e4c2404486ffb6ef0649a958", 10:52:27 INFO - "slavebuilddir": "test" 10:52:27 INFO - } 10:52:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 10:52:27 INFO - Running post-action listener: _resource_record_post_action 10:52:27 INFO - [mozharness: 2016-11-29 18:52:27.654736Z] Finished read-buildbot-config step (success) 10:52:27 INFO - [mozharness: 2016-11-29 18:52:27.654906Z] Running download-and-extract step. 10:52:27 INFO - Running pre-action listener: _resource_record_pre_action 10:52:27 INFO - Running main action method: download_and_extract 10:52:27 INFO - mkdir: /builds/slave/test/build/tests 10:52:27 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:52:27 INFO - trying https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 10:52:27 INFO - Downloading https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 10:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 10:52:29 INFO - Downloaded 1199 bytes. 10:52:29 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 10:52:29 INFO - Using the following test package requirements: 10:52:29 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 10:52:29 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:52:29 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 10:52:29 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:52:29 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 10:52:29 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:52:29 INFO - u'jsshell-mac.zip'], 10:52:29 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:52:29 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 10:52:29 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 10:52:29 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:52:29 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 10:52:29 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:52:29 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 10:52:29 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:52:29 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 10:52:29 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:52:29 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 10:52:29 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:52:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 10:52:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:52:29 INFO - Fetch https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 10:52:29 INFO - Http code: 200 10:52:29 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 10:52:29 INFO - x-amz-cf-id: kQaMcJ9a5qp8iGVzp6OzFiptfq2ZseH4jt687jQYLZwo1PATZ0ki-A== 10:52:29 INFO - x-amz-version-id: OCGY_fTei1v6Ks8PXdI_8E5UoNsQHzqd 10:52:30 INFO - Expected file size: 16284790 10:52:30 INFO - Obtained file size: 16284790 10:52:36 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:52:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 10:52:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:52:36 INFO - Fetch https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 10:52:37 INFO - Http code: 200 10:52:37 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 10:52:37 INFO - x-amz-cf-id: GKKnsFcVTQgVg_z6rVCd-gkHOzt3ViVadxWTyTO8SfczFFV8aacyEQ== 10:52:37 INFO - x-amz-version-id: OCGY_fTei1v6Ks8PXdI_8E5UoNsQHzqd 10:52:37 INFO - Expected file size: 16284790 10:52:37 INFO - Obtained file size: 16284790 10:52:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 10:52:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:52:43 INFO - Fetch https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 10:52:44 INFO - Http code: 200 10:52:44 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 10:52:44 INFO - x-amz-cf-id: hQqphRyGtwc46isWss4JmNUBzh5YT7PEQS0SgQVveqK8V4BZsqe1OQ== 10:52:44 INFO - x-amz-version-id: bjL_IjHNOlRfoEWW85mb5KjxaG_tkcwD 10:52:45 INFO - Expected file size: 14409702 10:52:45 INFO - Obtained file size: 14409702 10:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:45 INFO - trying https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 10:52:45 INFO - Downloading https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 10:52:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 10:52:48 INFO - Downloaded 107599747 bytes. 10:52:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 10:52:48 INFO - mkdir: /builds/slave/test/properties 10:52:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:52:48 INFO - Writing to file /builds/slave/test/properties/build_url 10:52:48 INFO - Contents: 10:52:48 INFO - build_url:https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 10:52:49 INFO - Running post-action listener: _resource_record_post_action 10:52:49 INFO - Running post-action listener: set_extra_try_arguments 10:52:49 INFO - [mozharness: 2016-11-29 18:52:49.052998Z] Finished download-and-extract step (success) 10:52:49 INFO - [mozharness: 2016-11-29 18:52:49.053103Z] Running populate-webroot step. 10:52:49 INFO - Running pre-action listener: _resource_record_pre_action 10:52:49 INFO - Running main action method: populate_webroot 10:52:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:52:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:52:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:52:49 INFO - '--tppagecycles', 10:52:49 INFO - '7'], 10:52:49 INFO - 'tests': ['tsvgm']}}, 10:52:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:52:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:52:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:52:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:52:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:52:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:52:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:52:49 INFO - 'talos_options': ['--disable-e10s'], 10:52:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:52:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:52:49 INFO - 'talos_options': ['--disable-e10s'], 10:52:49 INFO - 'tests': ['damp', 'tps']}, 10:52:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:52:49 INFO - 'tests': ['damp', 'tps']}, 10:52:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:52:49 INFO - 'tests': ['dromaeo_dom']}, 10:52:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:52:49 INFO - 'tests': ['basic_compositor_video']}, 10:52:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:52:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:52:49 INFO - 'tests': ['a11yr', 10:52:49 INFO - 'ts_paint', 10:52:49 INFO - 'tpaint', 10:52:49 INFO - 'sessionrestore', 10:52:49 INFO - 'sessionrestore_no_auto_restore', 10:52:49 INFO - 'tabpaint']}, 10:52:49 INFO - 'other-e10s': {'tests': ['a11yr', 10:52:49 INFO - 'ts_paint', 10:52:49 INFO - 'tpaint', 10:52:49 INFO - 'sessionrestore', 10:52:49 INFO - 'sessionrestore_no_auto_restore', 10:52:49 INFO - 'tabpaint']}, 10:52:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:52:49 INFO - 'ts_paint', 10:52:49 INFO - 'tpaint', 10:52:49 INFO - 'sessionrestore', 10:52:49 INFO - 'sessionrestore_no_auto_restore', 10:52:49 INFO - 'tabpaint']}, 10:52:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:52:49 INFO - 'ts_paint', 10:52:49 INFO - 'tpaint', 10:52:49 INFO - 'sessionrestore', 10:52:49 INFO - 'sessionrestore_no_auto_restore', 10:52:49 INFO - 'tabpaint']}, 10:52:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:52:49 INFO - 'tests': ['a11yr', 10:52:49 INFO - 'ts_paint', 10:52:49 INFO - 'tpaint', 10:52:49 INFO - 'sessionrestore', 10:52:49 INFO - 'sessionrestore_no_auto_restore', 10:52:49 INFO - 'tabpaint']}, 10:52:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:52:49 INFO - 'tests': ['a11yr', 10:52:49 INFO - 'ts_paint', 10:52:49 INFO - 'tpaint', 10:52:49 INFO - 'sessionrestore', 10:52:49 INFO - 'sessionrestore_no_auto_restore', 10:52:49 INFO - 'tabpaint']}, 10:52:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:52:49 INFO - 'tests': ['tsvgx', 10:52:49 INFO - 'tsvgr_opacity', 10:52:49 INFO - 'tart', 10:52:49 INFO - 'tscrollx', 10:52:49 INFO - 'cart', 10:52:49 INFO - 'tsvg_static']}, 10:52:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:52:49 INFO - 'tsvgr_opacity', 10:52:49 INFO - 'tart', 10:52:49 INFO - 'tscrollx', 10:52:49 INFO - 'cart', 10:52:49 INFO - 'tsvg_static']}, 10:52:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:52:49 INFO - 'talos_options': ['--disable-e10s'], 10:52:49 INFO - 'tests': ['tp5o']}, 10:52:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:52:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:52:49 INFO - 'talos_options': ['--disable-e10s', 10:52:49 INFO - '--xperf_path', 10:52:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:49 INFO - 'tests': ['tp5n']}, 10:52:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:52:49 INFO - 'talos_options': ['--xperf_path', 10:52:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:49 INFO - 'tests': ['tp5n']}}, 10:52:49 INFO - 'talos.zip': {'path': '', 10:52:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:52:49 INFO - Running post-action listener: _resource_record_post_action 10:52:49 INFO - [mozharness: 2016-11-29 18:52:49.071319Z] Finished populate-webroot step (success) 10:52:49 INFO - [mozharness: 2016-11-29 18:52:49.071441Z] Running create-virtualenv step. 10:52:49 INFO - Running pre-action listener: _resource_record_pre_action 10:52:49 INFO - Running main action method: create_virtualenv 10:52:49 INFO - Creating virtualenv /builds/slave/test/build/venv 10:52:49 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:52:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:52:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:49 INFO - Using real prefix '/tools/python27' 10:52:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:52:49 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:52 INFO - Installing pip.................done. 10:52:52 INFO - Return code: 0 10:52:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:52:53 INFO - Reading from file tmpfile_stdout 10:52:53 INFO - Output received: 10:52:53 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:52:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:53 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 0x10a7c43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7285d23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5dad30>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5d2b20>, '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.argJvf95jl/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.GbY65q7S80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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:52:53 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:52:53 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:52:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.argJvf95jl/Render', 10:52:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:53 INFO - 'HOME': '/Users/cltbld', 10:52:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:53 INFO - 'LOGNAME': 'cltbld', 10:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:53 INFO - 'MOZ_NO_REMOTE': '1', 10:52:53 INFO - 'NO_EM_RESTART': '1', 10:52:53 INFO - 'PAGER': '/bin/cat', 10:52:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:53 INFO - 'PWD': '/builds/slave/test', 10:52:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:53 INFO - 'SHELL': '/bin/bash', 10:52:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbY65q7S80/Listeners', 10:52:53 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 10:52:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:53 INFO - 'USER': 'cltbld', 10:52:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:53 INFO - 'XPC_FLAGS': '0x0', 10:52:53 INFO - 'XPC_SERVICE_NAME': '0', 10:52:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:53 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:52:53 INFO - Cleaning up... 10:52:53 INFO - Return code: 0 10:52:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:53 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 0x10a7c43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7285d23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5dad30>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5d2b20>, '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.argJvf95jl/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.GbY65q7S80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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:52:53 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:52:53 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:52:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.argJvf95jl/Render', 10:52:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:53 INFO - 'HOME': '/Users/cltbld', 10:52:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:53 INFO - 'LOGNAME': 'cltbld', 10:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:53 INFO - 'MOZ_NO_REMOTE': '1', 10:52:53 INFO - 'NO_EM_RESTART': '1', 10:52:53 INFO - 'PAGER': '/bin/cat', 10:52:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:53 INFO - 'PWD': '/builds/slave/test', 10:52:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:53 INFO - 'SHELL': '/bin/bash', 10:52:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbY65q7S80/Listeners', 10:52:53 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 10:52:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:53 INFO - 'USER': 'cltbld', 10:52:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:53 INFO - 'XPC_FLAGS': '0x0', 10:52:53 INFO - 'XPC_SERVICE_NAME': '0', 10:52:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:53 INFO - Downloading/unpacking psutil>=3.1.1 10:52:53 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:52:53 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:52:53 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:52:53 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:52:53 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:52:53 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:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:57 INFO - Installing collected packages: psutil 10:52:57 INFO - Running setup.py install for psutil 10:52:57 INFO - building 'psutil._psutil_osx' extension 10:52:57 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:52:57 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:52:57 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:52:57 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:52:57 INFO - building 'psutil._psutil_posix' extension 10:52:57 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:52:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:52:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:52:57 INFO - ^ 10:52:57 INFO - 1 warning generated. 10:52:57 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:52:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:58 INFO - Successfully installed psutil 10:52:58 INFO - Cleaning up... 10:52:58 INFO - Return code: 0 10:52:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a7c43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7285d23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5dad30>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5d2b20>, '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.argJvf95jl/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.GbY65q7S80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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:52:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.argJvf95jl/Render', 10:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:58 INFO - 'HOME': '/Users/cltbld', 10:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:58 INFO - 'LOGNAME': 'cltbld', 10:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:58 INFO - 'MOZ_NO_REMOTE': '1', 10:52:58 INFO - 'NO_EM_RESTART': '1', 10:52:58 INFO - 'PAGER': '/bin/cat', 10:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:58 INFO - 'PWD': '/builds/slave/test', 10:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:58 INFO - 'SHELL': '/bin/bash', 10:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbY65q7S80/Listeners', 10:52:58 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 10:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:58 INFO - 'USER': 'cltbld', 10:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:58 INFO - 'XPC_FLAGS': '0x0', 10:52:58 INFO - 'XPC_SERVICE_NAME': '0', 10:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:52:58 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:52:58 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:52:58 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:52:58 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:52:58 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:52:58 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:53:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:53:00 INFO - Installing collected packages: mozsystemmonitor 10:53:00 INFO - Running setup.py install for mozsystemmonitor 10:53:01 INFO - Successfully installed mozsystemmonitor 10:53:01 INFO - Cleaning up... 10:53:01 INFO - Return code: 0 10:53:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:53:01 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:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:01 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:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:01 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 0x10a7c43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7285d23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5dad30>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5d2b20>, '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.argJvf95jl/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.GbY65q7S80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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:53:01 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:53:01 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:53:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.argJvf95jl/Render', 10:53:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:01 INFO - 'HOME': '/Users/cltbld', 10:53:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:01 INFO - 'LOGNAME': 'cltbld', 10:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:01 INFO - 'MOZ_NO_REMOTE': '1', 10:53:01 INFO - 'NO_EM_RESTART': '1', 10:53:01 INFO - 'PAGER': '/bin/cat', 10:53:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:01 INFO - 'PWD': '/builds/slave/test', 10:53:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:01 INFO - 'SHELL': '/bin/bash', 10:53:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbY65q7S80/Listeners', 10:53:01 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 10:53:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:01 INFO - 'USER': 'cltbld', 10:53:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:01 INFO - 'XPC_FLAGS': '0x0', 10:53:01 INFO - 'XPC_SERVICE_NAME': '0', 10:53:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:01 INFO - Downloading/unpacking jsonschema==2.5.1 10:53:01 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:53:01 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:53:01 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:53:01 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:53:01 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:53:01 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:53:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:53:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:53:04 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:53:04 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:53:04 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:53:04 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:53:04 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:53:04 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:53:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:53:04 INFO - warning: no files found matching '*.txt' 10:53:04 INFO - no previously-included directories found matching 'build' 10:53:04 INFO - no previously-included directories found matching 'dist' 10:53:04 INFO - no previously-included directories found matching '.git*' 10:53:04 INFO - Installing collected packages: jsonschema, functools32 10:53:04 INFO - Running setup.py install for functools32 10:53:04 INFO - warning: no files found matching '*.txt' 10:53:04 INFO - no previously-included directories found matching 'build' 10:53:04 INFO - no previously-included directories found matching 'dist' 10:53:04 INFO - no previously-included directories found matching '.git*' 10:53:04 INFO - Successfully installed jsonschema functools32 10:53:04 INFO - Cleaning up... 10:53:04 INFO - Return code: 0 10:53:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:04 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 0x10a7c43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7285d23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5dad30>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5d2b20>, '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.argJvf95jl/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.GbY65q7S80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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:53:04 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:53:04 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:53:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.argJvf95jl/Render', 10:53:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:04 INFO - 'HOME': '/Users/cltbld', 10:53:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:04 INFO - 'LOGNAME': 'cltbld', 10:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:04 INFO - 'MOZ_NO_REMOTE': '1', 10:53:04 INFO - 'NO_EM_RESTART': '1', 10:53:04 INFO - 'PAGER': '/bin/cat', 10:53:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:04 INFO - 'PWD': '/builds/slave/test', 10:53:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:04 INFO - 'SHELL': '/bin/bash', 10:53:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbY65q7S80/Listeners', 10:53:04 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 10:53:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:04 INFO - 'USER': 'cltbld', 10:53:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:04 INFO - 'XPC_FLAGS': '0x0', 10:53:04 INFO - 'XPC_SERVICE_NAME': '0', 10:53:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:53:05 INFO - Cleaning up... 10:53:05 INFO - Return code: 0 10:53:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:53:05 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:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:05 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:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:05 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 0x10a7c43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7285d23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5dad30>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5d2b20>, '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.argJvf95jl/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.GbY65q7S80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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:53:05 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:53:05 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:53:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.argJvf95jl/Render', 10:53:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:05 INFO - 'HOME': '/Users/cltbld', 10:53:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:05 INFO - 'LOGNAME': 'cltbld', 10:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:05 INFO - 'MOZ_NO_REMOTE': '1', 10:53:05 INFO - 'NO_EM_RESTART': '1', 10:53:05 INFO - 'PAGER': '/bin/cat', 10:53:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:05 INFO - 'PWD': '/builds/slave/test', 10:53:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:05 INFO - 'SHELL': '/bin/bash', 10:53:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbY65q7S80/Listeners', 10:53:05 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 10:53:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:05 INFO - 'USER': 'cltbld', 10:53:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:05 INFO - 'XPC_FLAGS': '0x0', 10:53:05 INFO - 'XPC_SERVICE_NAME': '0', 10:53:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:05 INFO - Downloading/unpacking blobuploader==1.2.4 10:53:05 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:53:05 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:53:05 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:53:05 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:53:05 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:53:05 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:53:07 INFO - Downloading blobuploader-1.2.4.tar.gz 10:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:53:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:53:08 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:53:08 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:53:08 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:53:08 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:53:08 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:53:08 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:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:53:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:53:08 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:53:08 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:53:08 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:53:08 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:53:08 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:53:08 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:53:09 INFO - Downloading docopt-0.6.1.tar.gz 10:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:53:09 INFO - Installing collected packages: blobuploader, requests, docopt 10:53:09 INFO - Running setup.py install for blobuploader 10:53:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:53:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:53:09 INFO - Running setup.py install for requests 10:53:09 INFO - Running setup.py install for docopt 10:53:09 INFO - Successfully installed blobuploader requests docopt 10:53:09 INFO - Cleaning up... 10:53:10 INFO - Return code: 0 10:53:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53: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:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:10 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 0x10a7c43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7285d23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5dad30>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5d2b20>, '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.argJvf95jl/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.GbY65q7S80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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:53:10 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:53:10 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:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.argJvf95jl/Render', 10:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:10 INFO - 'HOME': '/Users/cltbld', 10:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:10 INFO - 'LOGNAME': 'cltbld', 10:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:10 INFO - 'MOZ_NO_REMOTE': '1', 10:53:10 INFO - 'NO_EM_RESTART': '1', 10:53:10 INFO - 'PAGER': '/bin/cat', 10:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:10 INFO - 'PWD': '/builds/slave/test', 10:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:10 INFO - 'SHELL': '/bin/bash', 10:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbY65q7S80/Listeners', 10:53:10 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 10:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:10 INFO - 'USER': 'cltbld', 10:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:10 INFO - 'XPC_FLAGS': '0x0', 10:53:10 INFO - 'XPC_SERVICE_NAME': '0', 10:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:10 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-D9Ey9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:10 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-Vmo3sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:10 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-v5Truz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:10 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-nVnOTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:10 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-LtKFA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:10 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-35G6YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:10 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-wDuhVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:11 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-2fD5al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:11 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-mcdcMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:11 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-pCY_Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:11 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-tRRIQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:11 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-fkmHKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:11 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-c23NNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:11 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-qe6A96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:11 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-MRhaXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:11 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-7PMozp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:12 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-QjfO5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:53:12 INFO - Running setup.py install for manifestparser 10:53:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:53:12 INFO - Running setup.py install for mozcrash 10:53:12 INFO - Running setup.py install for mozdebug 10:53:12 INFO - Running setup.py install for mozdevice 10:53:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:53:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:53:12 INFO - Running setup.py install for mozfile 10:53:12 INFO - Running setup.py install for mozhttpd 10:53:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:53:13 INFO - Running setup.py install for mozinfo 10:53:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:53:13 INFO - Running setup.py install for mozInstall 10:53:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:53:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:53:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:53:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:53:13 INFO - Running setup.py install for mozleak 10:53:13 INFO - Running setup.py install for mozlog 10:53:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:53:13 INFO - Running setup.py install for moznetwork 10:53:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:53:13 INFO - Running setup.py install for mozprocess 10:53:13 INFO - Running setup.py install for mozprofile 10:53:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:53:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:53:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:53:14 INFO - Running setup.py install for mozrunner 10:53:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:53:14 INFO - Running setup.py install for mozscreenshot 10:53:14 INFO - Running setup.py install for moztest 10:53:14 INFO - Running setup.py install for mozversion 10:53:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:53:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:53:14 INFO - Cleaning up... 10:53:14 INFO - Return code: 0 10:53:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53: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:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:14 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 0x10a7c43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7285d23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5dad30>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5d2b20>, '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.argJvf95jl/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.GbY65q7S80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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:53:14 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:53:14 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:53:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.argJvf95jl/Render', 10:53:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:14 INFO - 'HOME': '/Users/cltbld', 10:53:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:14 INFO - 'LOGNAME': 'cltbld', 10:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:14 INFO - 'MOZ_NO_REMOTE': '1', 10:53:14 INFO - 'NO_EM_RESTART': '1', 10:53:14 INFO - 'PAGER': '/bin/cat', 10:53:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:14 INFO - 'PWD': '/builds/slave/test', 10:53:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:14 INFO - 'SHELL': '/bin/bash', 10:53:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbY65q7S80/Listeners', 10:53:14 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 10:53:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:14 INFO - 'USER': 'cltbld', 10:53:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:14 INFO - 'XPC_FLAGS': '0x0', 10:53:14 INFO - 'XPC_SERVICE_NAME': '0', 10:53:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:15 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-dMlysg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:15 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-CTiOyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:15 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-9eeAY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:15 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-E1CgLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:15 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-d_zeNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:15 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-iwjq5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:15 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-h7UAjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:15 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-ihzA59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:15 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-rGBRit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:15 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-NRFzeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:16 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:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:16 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-5dPSoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:16 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:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:16 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-AcIC8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:16 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:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:16 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-ztnnH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:16 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:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:16 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-LzIe8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:16 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-yPLY9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:16 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:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:16 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-rrnxvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:16 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:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:16 INFO - Running setup.py (path:/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/pip-pKdqcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:16 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:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:53:16 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:53:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:53:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:53:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:19 INFO - Downloading blessings-1.6.tar.gz 10:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:53:19 INFO - Installing collected packages: blessings 10:53:19 INFO - Running setup.py install for blessings 10:53:19 INFO - Successfully installed blessings 10:53:19 INFO - Cleaning up... 10:53:19 INFO - Return code: 0 10:53:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:20 INFO - Reading from file tmpfile_stdout 10:53:20 INFO - Current package versions: 10:53:20 INFO - blessings == 1.6 10:53:20 INFO - blobuploader == 1.2.4 10:53:20 INFO - docopt == 0.6.1 10:53:20 INFO - functools32 == 3.2.3-2 10:53:20 INFO - jsonschema == 2.5.1 10:53:20 INFO - manifestparser == 1.1 10:53:20 INFO - mozInstall == 1.12 10:53:20 INFO - mozcrash == 1.0 10:53:20 INFO - mozdebug == 0.1 10:53:20 INFO - mozdevice == 0.49 10:53:20 INFO - mozfile == 1.2 10:53:20 INFO - mozhttpd == 0.7 10:53:20 INFO - mozinfo == 0.9 10:53:20 INFO - mozleak == 0.1 10:53:20 INFO - mozlog == 3.4 10:53:20 INFO - moznetwork == 0.27 10:53:20 INFO - mozprocess == 0.23 10:53:20 INFO - mozprofile == 0.28 10:53:20 INFO - mozrunner == 6.13 10:53:20 INFO - mozscreenshot == 0.1 10:53:20 INFO - mozsystemmonitor == 0.3 10:53:20 INFO - moztest == 0.7 10:53:20 INFO - mozversion == 1.4 10:53:20 INFO - psutil == 3.1.1 10:53:20 INFO - requests == 1.2.3 10:53:20 INFO - wsgiref == 0.1.2 10:53:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:20 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 0x10a7c43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7285d23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5dad30>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5d2b20>, '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.argJvf95jl/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.GbY65q7S80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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:53:20 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:53:20 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:53:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.argJvf95jl/Render', 10:53:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:20 INFO - 'HOME': '/Users/cltbld', 10:53:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:20 INFO - 'LOGNAME': 'cltbld', 10:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:20 INFO - 'MOZ_NO_REMOTE': '1', 10:53:20 INFO - 'NO_EM_RESTART': '1', 10:53:20 INFO - 'PAGER': '/bin/cat', 10:53:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:20 INFO - 'PWD': '/builds/slave/test', 10:53:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:20 INFO - 'SHELL': '/bin/bash', 10:53:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbY65q7S80/Listeners', 10:53:20 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 10:53:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:20 INFO - 'USER': 'cltbld', 10:53:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:20 INFO - 'XPC_FLAGS': '0x0', 10:53:20 INFO - 'XPC_SERVICE_NAME': '0', 10:53:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:20 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:53:20 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:53:20 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:53:20 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:53:20 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:53:20 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:53:20 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:53:20 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:53:20 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:53:20 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:53:20 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:53:20 INFO - Cleaning up... 10:53:20 INFO - Return code: 0 10:53:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:20 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 0x10a7c43f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7285d23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5dad30>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5d2b20>, '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.argJvf95jl/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.GbY65q7S80/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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:53:20 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:53:20 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:53:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.argJvf95jl/Render', 10:53:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:20 INFO - 'HOME': '/Users/cltbld', 10:53:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:20 INFO - 'LOGNAME': 'cltbld', 10:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:20 INFO - 'MOZ_NO_REMOTE': '1', 10:53:20 INFO - 'NO_EM_RESTART': '1', 10:53:20 INFO - 'PAGER': '/bin/cat', 10:53:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:20 INFO - 'PWD': '/builds/slave/test', 10:53:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:20 INFO - 'SHELL': '/bin/bash', 10:53:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbY65q7S80/Listeners', 10:53:20 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 10:53:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:20 INFO - 'USER': 'cltbld', 10:53:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:20 INFO - 'XPC_FLAGS': '0x0', 10:53:20 INFO - 'XPC_SERVICE_NAME': '0', 10:53:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:53:20 INFO - Cleaning up... 10:53:20 INFO - Return code: 0 10:53:20 INFO - Running post-action listener: _resource_record_post_action 10:53:20 INFO - Running post-action listener: _start_resource_monitoring 10:53:20 INFO - Starting resource monitoring. 10:53:20 INFO - [mozharness: 2016-11-29 18:53:20.634477Z] Finished create-virtualenv step (success) 10:53:20 INFO - [mozharness: 2016-11-29 18:53:20.635521Z] Running install step. 10:53:20 INFO - Running pre-action listener: _resource_record_pre_action 10:53:20 INFO - Running main action method: install 10:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:20 INFO - Reading from file tmpfile_stdout 10:53:20 INFO - Detecting whether we're running mozinstall >=1.0... 10:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:53:20 INFO - Reading from file tmpfile_stdout 10:53:20 INFO - Output received: 10:53:20 INFO - Usage: mozinstall [options] installer 10:53:20 INFO - Options: 10:53:20 INFO - -h, --help show this help message and exit 10:53:20 INFO - -d DEST, --destination=DEST 10:53:20 INFO - Directory to install application into. [default: 10:53:20 INFO - "/builds/slave/test"] 10:53:20 INFO - --app=APP Application being installed. [default: firefox] 10:53:20 INFO - mkdir: /builds/slave/test/build/application 10:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:53:53 INFO - Reading from file tmpfile_stdout 10:53:53 INFO - Output received: 10:53:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:53:53 INFO - Running post-action listener: _resource_record_post_action 10:53:53 INFO - [mozharness: 2016-11-29 18:53:53.772672Z] Finished install step (success) 10:53:53 INFO - [mozharness: 2016-11-29 18:53:53.772835Z] Running run-tests step. 10:53:53 INFO - Running pre-action listener: _resource_record_pre_action 10:53:53 INFO - Running main action method: run_tests 10:53:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:53:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:53:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:53:53 INFO - 2016-11-29 10:53:53.787 screenresolution[2157:16653] starting screenresolution argv=screenresolution get 10:53:53 INFO - 2016-11-29 10:53:53.790 screenresolution[2157:16653] Display 0: 1600x1200x32@60 10:53:53 INFO - 2016-11-29 10:53:53.797 screenresolution[2158:16656] starting screenresolution argv=screenresolution list 10:53:53 INFO - Available Modes on Display 0 10:53:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:53:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:53:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:53:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:53:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:53:54 INFO - Intel Iris: 10:53:54 INFO - Chipset Model: Intel Iris 10:53:54 INFO - Type: GPU 10:53:54 INFO - Bus: Built-In 10:53:54 INFO - VRAM (Dynamic, Max): 1536 MB 10:53:54 INFO - Vendor: Intel (0x8086) 10:53:54 INFO - Device ID: 0x0a2e 10:53:54 INFO - Revision ID: 0x0009 10:53:54 INFO - Displays: 10:53:54 INFO - Display: 10:53:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:53:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:53:54 INFO - Display Serial Number: 1600x1200 60 10:53:54 INFO - Main Display: Yes 10:53:54 INFO - Mirror: Off 10:53:54 INFO - Online: Yes 10:53:54 INFO - Rotation: Supported 10:53:54 INFO - Return code: 0 10:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:53:54 INFO - Python 2.7.3 10:53:54 INFO - Return code: 0 10:53:54 INFO - grabbing minidump binary from tooltool 10:53:54 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:53:54 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 0x10a5dad30>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5d2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:53:54 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:53:54 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:53:54 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:53:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:54 INFO - Return code: 0 10:53:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:53:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:53:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:53:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:53:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0089 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.argJvf95jl/Render', 10:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:54 INFO - 'HOME': '/Users/cltbld', 10:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:54 INFO - 'LOGNAME': 'cltbld', 10:53:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:53:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:54 INFO - 'MOZ_NO_REMOTE': '1', 10:53:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:53:54 INFO - 'NO_EM_RESTART': '1', 10:53:54 INFO - 'PAGER': '/bin/cat', 10:53:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:54 INFO - 'PWD': '/builds/slave/test', 10:53:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:54 INFO - 'SHELL': '/bin/bash', 10:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbY65q7S80/Listeners', 10:53:54 INFO - 'TMPDIR': '/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/', 10:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:54 INFO - 'USER': 'cltbld', 10:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:54 INFO - 'XPC_FLAGS': '0x0', 10:53:54 INFO - 'XPC_SERVICE_NAME': '0', 10:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:53:54 INFO - mozversion application_buildid: 20161129071027 10:53:54 INFO - mozversion application_changeset: 1ab6a9dfef56cedb1d917aac82240a3be0fb8f20 10:53:54 INFO - mozversion application_display_name: Nightly 10:53:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:54 INFO - mozversion application_name: Firefox 10:53:54 INFO - mozversion application_remotingname: firefox 10:53:54 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 10:53:54 INFO - mozversion application_vendor: Mozilla 10:53:54 INFO - mozversion application_version: 53.0a1 10:53:54 INFO - mozversion platform_buildid: 20161129071027 10:53:54 INFO - mozversion platform_changeset: 1ab6a9dfef56cedb1d917aac82240a3be0fb8f20 10:53:54 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 10:53:54 INFO - mozversion platform_version: 53.0a1 10:53:54 INFO - using testdate: 1480445634 10:53:54 INFO - actual date: 1480445634 10:53:54 INFO - starting webserver on 'localhost:50495' 10:53:54 INFO - SUITE-START | Running 2 tests 10:53:54 INFO - TEST-START | dromaeo_css 10:53:54 INFO - operating with platform_type : mac_ 10:53:54 INFO - Initialising browser for dromaeo_css test... 10:53:54 INFO - TEST-INFO | started process 2168 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/tmpgLy5aP/profile http://localhost:50495/getInfo.html) 10:53:56 INFO - PROCESS | 2168 | __metrics Screen width/height:1600/1200 10:53:56 INFO - PROCESS | 2168 | colorDepth:24 10:53:56 INFO - PROCESS | 2168 | Browser inner width/height: 1024/689 10:53:56 INFO - PROCESS | 2168 | __metrics 10:53:57 INFO - PROCESS | 2168 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:53:57 INFO - PROCESS | 2168 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:53:57 INFO - TEST-INFO | 2168: exit 0 10:53:57 INFO - Browser initialized. 10:53:57 INFO - Running cycle 1/1 for dromaeo_css test... 10:53:57 INFO - TEST-INFO | started process 2170 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/tmpgLy5aP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:10 INFO - PROCESS | 2170 | RSS: Main: 243994624 10:54:10 INFO - PROCESS | 2170 | 10:55:01 INFO - PROCESS | 2170 | 1480445701727 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:57:13 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:50495/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50495/tests/dromaeo/cssquery-ext.html) 10:57:16 INFO - PROCESS | 2170 | RSS: Main: 494051328 10:57:16 INFO - PROCESS | 2170 | 11:00:19 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:50495/tests/dromaeo/cssquery-ext.html (next: http://localhost:50495/tests/dromaeo/cssquery-jquery.html) 11:00:20 INFO - PROCESS | 2170 | RSS: Main: 376930304 11:00:20 INFO - PROCESS | 2170 | 11:03:22 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:50495/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50495/tests/dromaeo/cssquery-mootools.html) 11:03:23 INFO - PROCESS | 2170 | RSS: Main: 357691392 11:03:23 INFO - PROCESS | 2170 | 11:06:25 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:50495/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50495/tests/dromaeo/cssquery-prototype.html) 11:06:26 INFO - PROCESS | 2170 | RSS: Main: 367861760 11:06:26 INFO - PROCESS | 2170 | 11:09:29 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:50495/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50495/tests/dromaeo/cssquery-yui.html) 11:09:30 INFO - PROCESS | 2170 | RSS: Main: 330653696 11:09:30 INFO - PROCESS | 2170 | 11:12:33 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:50495/tests/dromaeo/cssquery-yui.html (next: http://localhost:50495/tests/dromaeo/cssquery-dojo.html) 11:12:34 INFO - PROCESS | 2170 | RSS: Main: 384823296 11:12:34 INFO - PROCESS | 2170 | 11:12:34 INFO - PROCESS | 2170 | __start_tp_report 11:12:34 INFO - PROCESS | 2170 | _x_x_mozilla_page_load 11:12:34 INFO - PROCESS | 2170 | _x_x_mozilla_page_load_details 11:12:34 INFO - PROCESS | 2170 | |i|pagename|runs| 11:12:34 INFO - PROCESS | 2170 | |0;dojo.html;2643.2334622959343;3180.6660300668427;3186.5857438532994;3208.8716451341948;3234.385466761315;5187.610929180308;5255.86860328492;5259.5529380002745;5345.599080068996;5369.838904832852;5241.135212689911;5277.234800953859;5277.472252774721;5278.973605131979;5293.100172970595;4797.496262892399;4827.613790896738;4830.130576496229;4861.975690121544;4905.386826646669;4874.220124780036;4924.80300787968;4938.975305123469;4941.678790878582;4946.356973593428;4855.514448555152;4875.97604503053;4898.583620392271;4899.289603007562;4931.876703082416;4924.285978533093;4930.506949305077;4932.827351042696;4933.80264789408;4981.501849814989;4722.1736196165875;4779.378680771512;4788.856334309976;4865.9026819463415;4902.558769710743;5204.76578553966;5227.947720522784;5244.108501554745;5263.02634012705;5324.440933701944;4696.647751418657;5634.915476267859;5655;5667.518260947824;5681.545476361881;5590.8043218487155;5704.11586204139;5717.71411429431;5746.138079288098;5749.338826034976;5282.867928301785;5328.8401347959625;5340.973295133577;5342.8664283392445;5386.757595908115;5719.170720245625;5794.362620111784;5805.506531944832;5806.390329015477;5818.33089194748;5451.018816612968;5542.0855558832345;5553.055980483327;5558.277423934863;5594.86012849682;5611.382747897728;5669.2346533218315;5684.289463817023;5714.485696287354;5791.536677065825;5597.076482380362;5651.858703532444;5654.4062873398525;5657.9434205658235;5707.571932105108;5650.519705824969;5652.660840349592;5662.433756624305;5665.801696940587;5669.6314739541795;4540.160070386989;4593.058423023273;4594.95405045952;4597.310403439511;4642.280446530793;4161.625453709181;4162.979185104055;4183.3515805050265;4203.600657937491;4228;5344.706041167696;5346.7861285548925;5360.597955153379;5369.140937449989;5371.6239863209985;5591.552675785927;5634.85912852182;5650.434956504317;5660.29246344207;5704.115862041307;5311.123664595376;5352.732363381815;5368.516833485005;5374.951884382586;5389.272448219519;5037.848864534069;5044.495550445;5048.419431765394;5071.264666623319;5072.695638261716;5756.56825738063;5810.5351571875;5910.320313163869;5918.260217472816;5925.85185370352;5669.177969194526;5686.317641883001;5706.372299047019;5763.827085187451;5825.621334613236;5962;5962.791302304398;5970.0746384310505;5978.133170690313;5995.340512543529;5497.615166938436;5617.634853734494;5660.801871934463;5666.235058267246;5680.517156041783;5550.333959924835;5574.191742197278;5632.831015069554;5748.109043098327;5753.827385178452;5517.972410137923;5539.086050801573;5547.972260138835;5551.389347171727;5551.555875529867;5533.087040638249;5540.473655002768;5544.112941929272;5559.416261292506;5566.749496272759;5356.0626890294825;5409.441880610044;5448.891022179613;5451.727413629382;5457.290552228185;5523.6685798852195;5527.723613819373;5538.778448862;5540.667559946416;5542.916856247079;5393.164059570773;5416.8645783854145;5431.5926305526455;5432.538234249975;5436.53789427903 11:12:34 INFO - PROCESS | 2170 | |1;ext.html;499.61779238882264;510.7752588860902;524.0671604543913;527.2565682387834;558.8882223555288;24490;36288.729894453696;37358.813205934;37639.62360376392;39163.41254881179;38213.42679859804;38633;38714.80642596783;38762.03094922628;38775.44898204068;8957.10428957104;9139.497327646977;9142;9156.26749860013;9164.221041211506;8198.098209196984;8426.410151289381;8463;8556.743297701049;8566.742997710078;10576.576936922515;10854.511546980404;10904.236703430763;11011.779764404708;11023.559057637725;10838.349699018045;10935.83596246057;10939.781204375948;10951.780964380669;10976.506057227443;8124.715634952749;8399.874001889977;10723.249372543925;10778.946105269424;10788.56845726178;29156.12531624055;29328.160853459154;29460.70539294601;35720.28559428823;36397.27205455876;3277.885274015398;3351.413502637053;3823.560290566593;3876.604422407931;4016.2369149861433;24186.637200442008;27702.722972770214;28300.575491367646;28441.57337639937;28717.712822871923;3106.301082256497;3114.2370119320685;3174.9682503175136;3180.157258326545;3182.618085829692;422744;434157.8292108519;435925;436144;437553.9999999968;59245;60409.09386359208;60524.697376512835;60544.69727651333;60601;62725;63784;64207.03689444662;64342;64404.67797660982;13883.514077007256;14347.85652143486;14357.928210358881;14362.281885905872;14376.568702938928;10542.631007914686;10769.515371808131;10846;10876.891231087588;10886.891131088747;15453.845461545465;17208.569785755455;17223;17360.218790154475;18588.349407770664;7934.801629959182;8241.426008565304;8256.25693687559;8258.298044666151;8378.49729016261;813.6175997281268;829.5064436660177;917.5320586500933;932.5943214701626;976.8485884687884;25739.742602574108;27746.861265693948;27783.859985902673;28240.43519129647;28340.43319133647;1004.2719028704131;1037.1391744851755;1040.2198351236573;1070.4861666400172;1092.2463500184847;14065.367058482392;14164.291785410689;14222.359993800304;14580.781288280685;14657.780133298009;555228;561109;562459;562897;566127;52373.214401784004;52657.73671131697;52845.471545284825;52855.73572132115;53069;1306.9085164038427;1358.7078778062764;1368.1790925444654;1368.8015237790266;1370.1436602123672;24507.877460612584;24756.628650569895;26634.334141646614;26973;27461.782261370277;33264.66735332616;36211.637883620824;44862;44880.32679509875;44958;519909;523511;524206;525829;527183;25125.87437062876;25262.74737252604;25656.743432565436;25683.486330273663;25701.10046148376;40839.59160408358;41990.58009419989;42663.7866810664;42832.78583607062;43083.569164307955;35147.472787908715;35407.29185416226;35457;36541.08647283839;36874.262514750095;34808;34854;35620;35822.28355432825;36121.91634250872;32595.34809303848;34110.65889341174;35528.111797205274;35603.46594801132;35870.461943071394;30463.695363046085;31677.8416107918;31833.5224971621;31848.52227216547;31972.36055278835;23410.64884026707;23451.06195752151;23559.41101472477;23872.761272387055;23982.40043998914 11:12:34 INFO - PROCESS | 2170 | |2;jquery.html;342.0849228314262;360.52050772472614;366.45581311752045;373.527487728024;392.60150946789014;14577.271136443189;14963.700725985474;15570.29933652984;19620.509487262825;20083.89958050208;18135;19163.137658805354;19227.94336662764;19264.614707705838;19414.611707765835;5597.692126933017;5785.450382213704;5785.479306862381;5810.738516766755;5921.851953701149;4644.303354496818;5579.082326430701;5871.911921321183;5910.763569457216;5913.940860591403;5002.399712034561;5825.126231065353;5867.7066146692705;5872.354041055481;5877.177195192677;5523.7790488380415;5776.855578610526;5823.242978412779;5826.446487583673;5826.941730582682;4847.975760121212;5084.084864724348;5099.872503187413;5100.336956195708;5107.61692873036;23976.640350394584;24656.0137594496;24684.889179986763;25090.623640645405;25194.748052519422;2346.4016675747744;2378.63131214662;2471.3821544613847;2659.6941351744604;2771.1686494051905;15119.924400378037;15154.090754554652;15276.236188190545;15673.608159795982;15912.681746365124;1654.2225154177518;1800.2438975630137;1817.391173956713;1825.4067428085793;1866.430738624719;88223;103650.48174759078;115391;115493.69012619785;116508.25237621443;10470.528826202839;10568.735781605521;10726.463676816127;10794.974477424632;10933.234673572773;13479.460821567027;13482;13491.662708432368;13498.122622029538;13530.458781648624;7172.390346820474;7636.579988100708;7814.6874125034365;7901.209879012168;7945.48354356965;7605.277498637621;7616.04799400075;7636.69453221876;7801.609919504002;7807.258310460497;6372.267189273293;6495.577787443801;6514.120593719787;6520.347965203442;6620.602763834089;1774.5297496163528;1820.7633007708912;1825.2607693884;1825.361123606727;1833.3766519383473;948.5541795356172;970.403202030746;1000.5197505197546;1003.4932359158724;1059.56557811297;20653.76077435359;21694.674579881314;21752.02115904788;21770.564588708137;21854.453638658844;850.2475309351269;882.1795729971188;894.7718331825342;957.3681370295571;992.6426486464867;6895.620740859201;11422.200445968703;11564.074874010059;11601.361925094032;11602.6519204424;510137;511418;513721;522975;524810;82499.3500129994;106739.39890901643;107288.46355768171;113838;116793.41603292098;872.4372779557277;887.9822403551893;943.4433684126399;998.8951160128228;1003.4079892863246;18642;19002.42992710221;19112.808871911104;19139.86555713844;19177.137028834015;47855.76072119617;48522.5147748518;48988.510114898396;49264.75367623139;50200.49799502104;67785.32214677791;68370.65814671094;68457;70312;70927;7844.686212551434;7856.882146767689;8178.3457323412795;8348.373871959506;8355.874661879956;11614.303141811519;12594.055445841415;12621.495140194289;13036.152650077714;13111.868881311446;8752.431091979;11144.832827507757;11240.662780116609;11279.32324060559;11410.429478526206;10519.631812886511;10802.72993175177;11005.61480348184;11237.101031917264;11326.433678316216;11217.887821121685;11468.42462933492;11567.884321157017;11590.826137608112;11706.76586468283;7826.373890088666;7923.445358824827;8333.208345207195;8338.499690018618;8362.623681934449;10096.646617368357;11106.888931110585;11351.432428378714;11397.886021140013;11445.370504621993 11:12:34 INFO - PROCESS | 2170 | |3;mootools.html;1296.1380681846572;1443.1701771481398;1478.889083318751;1625.2686291168977;1838.4392760208138;7474.626268686564;7816.491928024674;7820.217978202177;7824.100228473721;7827.178146294643;7898.249666281708;8192.50844949302;8213.301869341098;8313.792155196123;8314;1936.9225230990778;2316.143027079983;2319.8840057997118;2320.0487800002;2321.872297023663;2034.7253120828648;2121.893905304736;2269.7503274639776;2326.9418264543438;2337.030132495021;2060.4333808202714;2222.7777222277805;2311.3528212100637;2312.4912519245822;2314.8379613426982;2257.7177852768405;2290.0725206291563;2290.874001929893;2295.8278129140213;2307.849989750661;2017.1326329678232;2091.843111766608;2094.8428867834823;2252.6958860553777;2289.095807156181;8043.798905027421;8293.83412331756;8298.170182981714;8390.580470976427;8409.32725381968;4983.152864013126;5137.12668846297;5146.176611742141;5149.845504634867;5149.922751158698;3395.847186876572;3437.123533498967;3444.19061520545;3489.2498112905846;3528.188516641161;921.4885738415177;1040.7242080848582;1050.2648146297545;1059.4861492176287;1084.6583326252205;10641.627543036035;10666.986636269541;10736.78526429475;10796.406197659126;10806.78386432267;4354.346847972829;4493.168763778712;4590.517995610479;4592.448906131285;4678.532146785362;9314.161725444743;9333.020032896584;9351.579178936965;9353.766155846159;9355.625774969061;5106.514881086291;5110.565601923804;5111.923321150186;5115.104856650071;5131.050755610224;4500.594946454835;4639.443266808004;4698.859034228979;4712.198926182557;4723.905521889543;3694.3165514379925;3715.331240376758;3737.9626203738158;3766.1902690921584;3801.3157631626573;1211.9091068169923;1212.9757404851853;1215.6596153077153;1225.2832093225384;1229.4037391864938;762.2415696382135;769.9615019249015;779.1974266505508;806.846699127164;879.0533576468652;5255.264263003182;5376.704281264568;5458.372287187024;5492.368377636543;5548.223248745179;410.3536929336307;426.6373582454888;434.36799456790294;437.5078037208141;439.6351028646216;3154.4322022036254;3345.1302661308237;3530.4174811156386;3698.1679122197293;3755.605661405568;9167.587458564381;9610.711678649652;9612.567434465465;9613.951930240304;9635.807283854283;9803.264755143393;9811.656592019388;10113.797724045478;10137.64518241858;10149.391036537683;7621.428392870557;7894.802629934297;7896.131425543185;7898.9210107899335;7911.327537159175;5151.871203219949;5517.779288828562;5529.33647962231;5585.888282234414;5619.466150715675;9167.44995300284;9193.494357810385;9314.115159059878;9399.10708482693;9443.480608566595;8915.910840891507;9455.385399948982;9488.430694158373;9505.001974792547;9563.474008929297;7007.948807678889;7032.929670703227;7107.786766397016;7119.786406407816;7123.501354905314;7765.107012693613;7801.804954876174;7815.452918295665;7893;7896.249856263876;7039.507234493536;7067;7094.787156385317;7116.50184487081;7285.672144753393;6983.057287266154;6998.475114366341;7032.050673159058;7037.049998250375;7091.645417729196;6557.2131344239;6608.603483790988;6649.767258145942;6725.529212955046;6752.966235168793;4731.929021064618;4751.358566593465;4788.257820037899;4802.663813533159;4978.079055374767;4825.879353016062;4895.216765317532;4902.338184345068;4957.801687932587;4960.851174464772 11:12:34 INFO - PROCESS | 2170 | |4;prototype.html;297.9165833566602;297.93594377208905;306.62438512821797;312.2178941750914;313.3998393077257;4555.498895121534;4631.661011189349;5036.52153045461;5215.374155101388;5224.2163675448655;4944.431390390107;5105.259737338084;5136.330692524925;5157.819476318329;5222.843314700555;3993.2412841560085;4037.6971727120435;4055.9797201013953;4063.4920634920636;4094.7133700640966;4025.859094931678;4043.614267582126;4046.7571945683208;4052.837886484537;4077.3476243800997;2897.579850921615;3424.5376874121926;3829.770213787168;3975.423563583279;4005.379166229239;3943.653526151935;3957.960420395788;3976.2445135424177;3979.323515002442;3981.8145483613284;3457.3258214648154;3457.827108644583;3457.930841383158;3458.792472451661;3463.8960831175104;4069.4506241657296;4472.418585583853;5038.874028149289;5092.541671249568;5108.310378098983;3767.4913886625227;4472.508024117345;4488.124815660947;4491.932621010687;4501.617362524189;4776.522347765195;5484.382107278362;5485.341758988907;5502.422245664187;5530.253415788858;3405.863765449379;3532.3994920863515;3613.8012409317475;3751.874437668716;3763.7929913854728;5387.542058924996;5657.632253903483;5673.999999999959;5711.485966263056;5773.769049238025;3178.4278829810855;3816.1491676536857;3816.484774555455;3828.291766023239;3841.2893614680816;3886.047918259988;3891;3898.3762597984187;3898.4542164097047;3905.9218815624095;3762.2287431076566;4386.539413361615;4476.507584165739;4477.522417602184;4540.455145382575;5123.615728820353;5408.215808707715;5489.917651235235;5514.711394771205;5530.469530469531;1184.5311813351382;1207.4204381896564;1214.678110300771;1238.4984081447028;1253.4422182128865;762.5615271219071;787.6258777080841;819.6844214977276;819.8852160697508;839.5340585974842;4227.852025179165;4646.95353046472;4892.28186578196;4920.31115643803;4948.406191257072;4379.700657155019;5346.4118946915805;5348.8662783429945;5360.973195133999;5431.474364420564;4876.853694389174;5261.106391484668;5318.627696061239;5326.893462130735;5335.078717142975;2516.7231604523486;2671.4389978104427;2838.4606924684244;2846.6299381080325;2850.572414137896;5238.97380513095;5280.498352656491;5601.759296281439;5620.91568626471;5623.353314368818;4803.207470767354;4844.709317440965;4978.158081509792;5579.972100139555;5604.635698679573;5585.519837243215;5596.285801386324;5605.495505404451;5606.439356064361;5615.354234263031;4803.678988278251;4946.851594452172;5313.442088580643;5350.919736203882;5421.701806400528;5245.527902488794;5652.382475215947;5663.603547751783;5705.914411283751;5708.8572785679025;5608.364068887617;5721.312212897288;5918.437748413894;5944.078667806497;5954.642721436728;3422.7775194612273;3760.266747984117;3770.45328427371;3822;3882.4758657581997;4749.4063242094735;4749.430068391815;5669.149627555899;5689.54483641316;5709.571782116275;4878.438979517259;5152.381714194171;5529.944700552943;5562.972185139049;5572.4706152915405;4850.854474365775;5517.806876759294;5574.442555744393;5575;5596.608237423504;5192.324997750419;5322.680639161508;5343.732813359239;5460.781568737365;5576.804811831566;4876.487968763229;5282.751108068587;5542.750576223999;5552.639078459887;5575;4748.382710247645;4778.20475022116;5144.768485418091;5388.326459192601;5424 11:12:34 INFO - PROCESS | 2170 | |5;yui.html;694.9861002779944;719.3813320544334;731.5025782467922;765.3953376832303;766.1036587192983;13896.791548126786;14608.561743147697;14620.195889226088;14621.12273263605;14631.487897923575;12795;12878.80681789774;12893.613191604243;12914.483420663162;12933.094683372168;646.0728854094377;674.0798809624852;677.2211956250302;794.9761507154794;818.2880893622556;821.9260266576007;836.8284501677172;838.8154605986673;839.3495041342946;839.8488272111017;885.4864178776327;885.6723012485389;886.0563499872648;886.6852267445029;886.7384121684119;673.8147009572358;697.1285892634207;701.1060897355861;881.3169793410126;881.7839629290864;519.5531842615347;519.7531172692978;615.1910238036967;639.1882309466997;642.4025656139788;12801.231926084465;12823;12830.101892867502;12836.871631283755;12917.418716157796;10849.566017359375;12678.87321126786;12737.936310318482;12825.294608796512;13171.934140329333;9740.853887191697;9908.306418550632;10020.498975051218;10061.19510439163;10072.647457339031;4219.451471308741;4278.315469524892;4292.527821939584;4378.671599630041;4381.890452738675;99939;103256.48371758094;103734;104437;104506.47746761293;8391.748247552583;10039.69880903574;10079.748006299902;10110.545025473872;10461.633842815465;20090.799092008892;20349.08429120693;20375.59248815045;20405;20653.070611822503;7223.458240631973;7265.237150099163;7301.269873012762;7438.144613369532;7467.439942004371;4001.419794129893;4066.959330406658;4140.130572579732;4208.190517702568;4226.1336426032585;3251.1872031992;3316.701496865294;3368.2589830237307;3380.5436266104252;3380.5436266104252;608.5223099866583;616.7255571270831;627.4039662320813;628.8239292997968;631.1227393922452;509.9291487875506;527.604296777417;533.5438200338732;592.4431034827248;614.5728718540661;7883.36933045355;8339.041010283774;8486.702965396305;8499.70251041223;8756.12438756132;509.53377659441196;558.020673717623;570.2700543304577;589.0927970924813;635.5551114220065;4122.237386083584;4152.875413737593;4343.978280108642;4482.798274077674;4537.241119119949;100905;101171;102331.48834255782;102873.48563257136;105344;76683.61658191784;87480;89248.5537572308;92867;92969;81248;83130.58434707788;83142;83566;87868.12131878728;8388.203120703523;8470.237678608955;8549.187827156411;8597;8779.956100219713;40758;52045;52239.73880130575;52667.68330791761;53291;59417.81164376602;67442.3255767436;69205.3079469219;69208;70012.94980575194;9723.222142228746;9725.367851089657;9730.659426920023;9784.412935223909;10172.84740728875;9726.31915765918;11932;11980.520779169085;12296.323702196107;12585.119041667362;11508.712282192677;11844.585439509576;11864.703382415508;11888.04895608332;12095.879041209828;11810.468528916048;11824.290542567473;11886.227395219283;11899.226550274205;11947.10396720232;11107.666769996913;11450;11571.710707232387;11629.418529073344;12084.45619947122;9579.473128977974;9882.703518894445;10037.69886903394;10076.84884726715;10110.44392558387;9382.718518444457;10029.097381235724;10036.849447258151;10048.296619236584;10061 11:12:34 INFO - PROCESS | 2170 | __end_tp_report 11:12:34 INFO - PROCESS | 2170 | __start_cc_report 11:12:34 INFO - PROCESS | 2170 | _x_x_mozilla_cycle_collect,3326 11:12:34 INFO - PROCESS | 2170 | __end_cc_report 11:12:34 INFO - PROCESS | 2170 | __startTimestamp1480446754081__endTimestamp 11:12:34 INFO - PROCESS | 2170 | 11:12:34 INFO - PROCESS | 2170 | ------- Summary: start ------- 11:12:34 INFO - PROCESS | 2170 | Number of tests: 6 11:12:34 INFO - PROCESS | 2170 | 11:12:34 INFO - PROCESS | 2170 | [#0] dojo.html Cycles:165 Average:5293.22 Median:5436.54 stddev:558.45 (10.3%) stddev-sans-first:520.04 11:12:34 INFO - PROCESS | 2170 | Values: 2643.2 3180.7 3186.6 3208.9 3234.4 5187.6 5255.9 5259.6 5345.6 5369.8 5241.1 5277.2 5277.5 5279.0 5293.1 4797.5 4827.6 4830.1 4862.0 4905.4 4874.2 4924.8 4939.0 4941.7 4946.4 4855.5 4876.0 4898.6 4899.3 4931.9 4924.3 4930.5 4932.8 4933.8 4981.5 4722.2 4779.4 4788.9 4865.9 4902.6 5204.8 5227.9 5244.1 5263.0 5324.4 4696.6 5634.9 5655.0 5667.5 5681.5 5590.8 5704.1 5717.7 5746.1 5749.3 5282.9 5328.8 5341.0 5342.9 5386.8 5719.2 5794.4 5805.5 5806.4 5818.3 5451.0 5542.1 5553.1 5558.3 5594.9 5611.4 5669.2 5684.3 5714.5 5791.5 5597.1 5651.9 5654.4 5657.9 5707.6 5650.5 5652.7 5662.4 5665.8 5669.6 4540.2 4593.1 4595.0 4597.3 4642.3 4161.6 4163.0 4183.4 4203.6 4228.0 5344.7 5346.8 5360.6 5369.1 5371.6 5591.6 5634.9 5650.4 5660.3 5704.1 5311.1 5352.7 5368.5 5375.0 5389.3 5037.8 5044.5 5048.4 5071.3 5072.7 5756.6 5810.5 5910.3 5918.3 5925.9 5669.2 5686.3 5706.4 5763.8 5825.6 5962.0 5962.8 5970.1 5978.1 5995.3 5497.6 5617.6 5660.8 5666.2 5680.5 5550.3 5574.2 5632.8 5748.1 5753.8 5518.0 5539.1 5548.0 5551.4 5551.6 5533.1 5540.5 5544.1 5559.4 5566.7 5356.1 5409.4 5448.9 5451.7 5457.3 5523.7 5527.7 5538.8 5540.7 5542.9 5393.2 5416.9 5431.6 5432.5 5436.5 11:12:34 INFO - PROCESS | 2170 | 11:12:34 INFO - PROCESS | 2170 | [#1] ext.html Cycles:180 Average:63251.73 Median:35432.15 stddev:135897.60 (383.5%) stddev-sans-first:136197.15 11:12:34 INFO - PROCESS | 2170 | Values: 499.6 510.8 524.1 527.3 558.9 24490.0 36288.7 37358.8 37639.6 39163.4 38213.4 38633.0 38714.8 38762.0 38775.4 8957.1 9139.5 9142.0 9156.3 9164.2 8198.1 8426.4 8463.0 8556.7 8566.7 10576.6 10854.5 10904.2 11011.8 11023.6 10838.3 10935.8 10939.8 10951.8 10976.5 8124.7 8399.9 10723.2 10778.9 10788.6 29156.1 29328.2 29460.7 35720.3 36397.3 3277.9 3351.4 3823.6 3876.6 4016.2 24186.6 27702.7 28300.6 28441.6 28717.7 3106.3 3114.2 3175.0 3180.2 3182.6 422744.0 434157.8 435925.0 436144.0 437554.0 59245.0 60409.1 60524.7 60544.7 60601.0 62725.0 63784.0 64207.0 64342.0 64404.7 13883.5 14347.9 14357.9 14362.3 14376.6 10542.6 10769.5 10846.0 10876.9 10886.9 15453.8 17208.6 17223.0 17360.2 18588.3 7934.8 8241.4 8256.3 8258.3 8378.5 813.6 829.5 917.5 932.6 976.8 25739.7 27746.9 27783.9 28240.4 28340.4 1004.3 1037.1 1040.2 1070.5 1092.2 14065.4 14164.3 14222.4 14580.8 14657.8 555228.0 561109.0 562459.0 562897.0 566127.0 52373.2 52657.7 52845.5 52855.7 53069.0 1306.9 1358.7 1368.2 1368.8 1370.1 24507.9 24756.6 26634.3 26973.0 27461.8 33264.7 36211.6 44862.0 44880.3 44958.0 519909.0 523511.0 524206.0 525829.0 527183.0 25125.9 25262.7 25656.7 25683.5 25701.1 40839.6 41990.6 42663.8 42832.8 43083.6 35147.5 35407.3 35457.0 36541.1 36874.3 34808.0 34854.0 35620.0 35822.3 36121.9 32595.3 34110.7 35528.1 35603.5 35870.5 30463.7 31677.8 31833.5 31848.5 31972.4 23410.6 23451.1 23559.4 23872.8 23982.4 11:12:34 INFO - PROCESS | 2170 | 11:12:34 INFO - PROCESS | 2170 | [#2] jquery.html Cycles:180 Average:31440.68 Median:13781.00 stddev:86100.72 (624.8%) stddev-sans-first:86310.59 11:12:34 INFO - PROCESS | 2170 | Values: 342.1 360.5 366.5 373.5 392.6 14577.3 14963.7 15570.3 19620.5 20083.9 18135.0 19163.1 19227.9 19264.6 19414.6 5597.7 5785.5 5785.5 5810.7 5921.9 4644.3 5579.1 5871.9 5910.8 5913.9 5002.4 5825.1 5867.7 5872.4 5877.2 5523.8 5776.9 5823.2 5826.4 5826.9 4848.0 5084.1 5099.9 5100.3 5107.6 23976.6 24656.0 24684.9 25090.6 25194.7 2346.4 2378.6 2471.4 2659.7 2771.2 15119.9 15154.1 15276.2 15673.6 15912.7 1654.2 1800.2 1817.4 1825.4 1866.4 88223.0 103650.5 115391.0 115493.7 116508.3 10470.5 10568.7 10726.5 10795.0 10933.2 13479.5 13482.0 13491.7 13498.1 13530.5 7172.4 7636.6 7814.7 7901.2 7945.5 7605.3 7616.0 7636.7 7801.6 7807.3 6372.3 6495.6 6514.1 6520.3 6620.6 1774.5 1820.8 1825.3 1825.4 1833.4 948.6 970.4 1000.5 1003.5 1059.6 20653.8 21694.7 21752.0 21770.6 21854.5 850.2 882.2 894.8 957.4 992.6 6895.6 11422.2 11564.1 11601.4 11602.7 510137.0 511418.0 513721.0 522975.0 524810.0 82499.4 106739.4 107288.5 113838.0 116793.4 872.4 888.0 943.4 998.9 1003.4 18642.0 19002.4 19112.8 19139.9 19177.1 47855.8 48522.5 48988.5 49264.8 50200.5 67785.3 68370.7 68457.0 70312.0 70927.0 7844.7 7856.9 8178.3 8348.4 8355.9 11614.3 12594.1 12621.5 13036.2 13111.9 8752.4 11144.8 11240.7 11279.3 11410.4 10519.6 10802.7 11005.6 11237.1 11326.4 11217.9 11468.4 11567.9 11590.8 11706.8 7826.4 7923.4 8333.2 8338.5 8362.6 10096.6 11106.9 11351.4 11397.9 11445.4 11:12:34 INFO - PROCESS | 2170 | 11:12:34 INFO - PROCESS | 2170 | [#3] mootools.html Cycles:180 Average:5360.88 Median:5113.51 stddev:2976.09 (58.2%) stddev-sans-first:2968.76 11:12:34 INFO - PROCESS | 2170 | Values: 1296.1 1443.2 1478.9 1625.3 1838.4 7474.6 7816.5 7820.2 7824.1 7827.2 7898.2 8192.5 8213.3 8313.8 8314.0 1936.9 2316.1 2319.9 2320.0 2321.9 2034.7 2121.9 2269.8 2326.9 2337.0 2060.4 2222.8 2311.4 2312.5 2314.8 2257.7 2290.1 2290.9 2295.8 2307.8 2017.1 2091.8 2094.8 2252.7 2289.1 8043.8 8293.8 8298.2 8390.6 8409.3 4983.2 5137.1 5146.2 5149.8 5149.9 3395.8 3437.1 3444.2 3489.2 3528.2 921.5 1040.7 1050.3 1059.5 1084.7 10641.6 10667.0 10736.8 10796.4 10806.8 4354.3 4493.2 4590.5 4592.4 4678.5 9314.2 9333.0 9351.6 9353.8 9355.6 5106.5 5110.6 5111.9 5115.1 5131.1 4500.6 4639.4 4698.9 4712.2 4723.9 3694.3 3715.3 3738.0 3766.2 3801.3 1211.9 1213.0 1215.7 1225.3 1229.4 762.2 770.0 779.2 806.8 879.1 5255.3 5376.7 5458.4 5492.4 5548.2 410.4 426.6 434.4 437.5 439.6 3154.4 3345.1 3530.4 3698.2 3755.6 9167.6 9610.7 9612.6 9614.0 9635.8 9803.3 9811.7 10113.8 10137.6 10149.4 7621.4 7894.8 7896.1 7898.9 7911.3 5151.9 5517.8 5529.3 5585.9 5619.5 9167.4 9193.5 9314.1 9399.1 9443.5 8915.9 9455.4 9488.4 9505.0 9563.5 7007.9 7032.9 7107.8 7119.8 7123.5 7765.1 7801.8 7815.5 7893.0 7896.2 7039.5 7067.0 7094.8 7116.5 7285.7 6983.1 6998.5 7032.1 7037.0 7091.6 6557.2 6608.6 6649.8 6725.5 6753.0 4731.9 4751.4 4788.3 4802.7 4978.1 4825.9 4895.2 4902.3 4957.8 4960.9 11:12:34 INFO - PROCESS | 2170 | 11:12:34 INFO - PROCESS | 2170 | [#4] prototype.html Cycles:180 Average:4414.48 Median:4932.37 stddev:1361.55 (27.6%) stddev-sans-first:1329.84 11:12:34 INFO - PROCESS | 2170 | Values: 297.9 297.9 306.6 312.2 313.4 4555.5 4631.7 5036.5 5215.4 5224.2 4944.4 5105.3 5136.3 5157.8 5222.8 3993.2 4037.7 4056.0 4063.5 4094.7 4025.9 4043.6 4046.8 4052.8 4077.3 2897.6 3424.5 3829.8 3975.4 4005.4 3943.7 3958.0 3976.2 3979.3 3981.8 3457.3 3457.8 3457.9 3458.8 3463.9 4069.5 4472.4 5038.9 5092.5 5108.3 3767.5 4472.5 4488.1 4491.9 4501.6 4776.5 5484.4 5485.3 5502.4 5530.3 3405.9 3532.4 3613.8 3751.9 3763.8 5387.5 5657.6 5674.0 5711.5 5773.8 3178.4 3816.1 3816.5 3828.3 3841.3 3886.0 3891.0 3898.4 3898.5 3905.9 3762.2 4386.5 4476.5 4477.5 4540.5 5123.6 5408.2 5489.9 5514.7 5530.5 1184.5 1207.4 1214.7 1238.5 1253.4 762.6 787.6 819.7 819.9 839.5 4227.9 4647.0 4892.3 4920.3 4948.4 4379.7 5346.4 5348.9 5361.0 5431.5 4876.9 5261.1 5318.6 5326.9 5335.1 2516.7 2671.4 2838.5 2846.6 2850.6 5239.0 5280.5 5601.8 5620.9 5623.4 4803.2 4844.7 4978.2 5580.0 5604.6 5585.5 5596.3 5605.5 5606.4 5615.4 4803.7 4946.9 5313.4 5350.9 5421.7 5245.5 5652.4 5663.6 5705.9 5708.9 5608.4 5721.3 5918.4 5944.1 5954.6 3422.8 3760.3 3770.5 3822.0 3882.5 4749.4 4749.4 5669.1 5689.5 5709.6 4878.4 5152.4 5529.9 5563.0 5572.5 4850.9 5517.8 5574.4 5575.0 5596.6 5192.3 5322.7 5343.7 5460.8 5576.8 4876.5 5282.8 5542.8 5552.6 5575.0 4748.4 4778.2 5144.8 5388.3 5424.0 11:12:34 INFO - PROCESS | 2170 | 11:12:34 INFO - PROCESS | 2170 | [#5] yui.html Cycles:180 Average:19742.91 Median:514.74 stddev:29608.76 (5752.2%) stddev-sans-first:29657.28 11:12:34 INFO - PROCESS | 2170 | Values: 695.0 719.4 731.5 765.4 766.1 13896.8 14608.6 14620.2 14621.1 14631.5 12795.0 12878.8 12893.6 12914.5 12933.1 646.1 674.1 677.2 795.0 818.3 821.9 836.8 838.8 839.3 839.8 885.5 885.7 886.1 886.7 886.7 673.8 697.1 701.1 881.3 881.8 519.6 519.8 615.2 639.2 642.4 12801.2 12823.0 12830.1 12836.9 12917.4 10849.6 12678.9 12737.9 12825.3 13171.9 9740.9 9908.3 10020.5 10061.2 10072.6 4219.5 4278.3 4292.5 4378.7 4381.9 99939.0 103256.5 103734.0 104437.0 104506.5 8391.7 10039.7 10079.7 10110.5 10461.6 20090.8 20349.1 20375.6 20405.0 20653.1 7223.5 7265.2 7301.3 7438.1 7467.4 4001.4 4067.0 4140.1 4208.2 4226.1 3251.2 3316.7 3368.3 3380.5 3380.5 608.5 616.7 627.4 628.8 631.1 509.9 527.6 533.5 592.4 614.6 7883.4 8339.0 8486.7 8499.7 8756.1 509.5 558.0 570.3 589.1 635.6 4122.2 4152.9 4344.0 4482.8 4537.2 100905.0 101171.0 102331.5 102873.5 105344.0 76683.6 87480.0 89248.6 92867.0 92969.0 81248.0 83130.6 83142.0 83566.0 87868.1 8388.2 8470.2 8549.2 8597.0 8780.0 40758.0 52045.0 52239.7 52667.7 53291.0 59417.8 67442.3 69205.3 69208.0 70012.9 9723.2 9725.4 9730.7 9784.4 10172.8 9726.3 11932.0 11980.5 12296.3 12585.1 11508.7 11844.6 11864.7 11888.0 12095.9 11810.5 11824.3 11886.2 11899.2 11947.1 11107.7 11450.0 11571.7 11629.4 12084.5 9579.5 9882.7 10037.7 10076.8 10110.4 9382.7 10029.1 10036.8 10048.3 10061.0 11:12:34 INFO - PROCESS | 2170 | -------- Summary: end -------- 11:12:34 INFO - PROCESS | 2170 | 11:12:34 INFO - TEST-INFO | 2170: exit 0 11:12:34 INFO - TEST-OK | dromaeo_css | took 1120361ms 11:12:34 INFO - TEST-START | kraken 11:12:34 INFO - operating with platform_type : mac_ 11:12:34 INFO - Initialising browser for kraken test... 11:12:34 INFO - TEST-INFO | started process 2175 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/tmpqW_Sar/profile http://localhost:50495/getInfo.html) 11:12:37 INFO - PROCESS | 2175 | __metrics Screen width/height:1600/1200 11:12:37 INFO - PROCESS | 2175 | colorDepth:24 11:12:37 INFO - PROCESS | 2175 | Browser inner width/height: 1024/689 11:12:37 INFO - PROCESS | 2175 | __metrics 11:12:37 INFO - PROCESS | 2175 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:12:37 INFO - PROCESS | 2175 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:12:38 INFO - TEST-INFO | 2175: exit 0 11:12:38 INFO - Browser initialized. 11:12:38 INFO - Running cycle 1/1 for kraken test... 11:12:38 INFO - TEST-INFO | started process 2176 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/tmpqW_Sar/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:12:50 INFO - PROCESS | 2176 | RSS: Main: 244215808 11:12:50 INFO - PROCESS | 2176 | 11:12:53 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50495/tests/kraken/driver.html?testName=audio-beat-detection) 11:12:54 INFO - PROCESS | 2176 | RSS: Main: 295231488 11:12:54 INFO - PROCESS | 2176 | 11:12:57 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50495/tests/kraken/driver.html?testName=audio-dft) 11:12:57 INFO - PROCESS | 2176 | RSS: Main: 295907328 11:12:57 INFO - PROCESS | 2176 | 11:13:01 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50495/tests/kraken/driver.html?testName=audio-fft) 11:13:01 INFO - PROCESS | 2176 | RSS: Main: 389955584 11:13:01 INFO - PROCESS | 2176 | 11:13:03 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50495/tests/kraken/driver.html?testName=audio-oscillator) 11:13:04 INFO - PROCESS | 2176 | RSS: Main: 291450880 11:13:04 INFO - PROCESS | 2176 | 11:13:06 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50495/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:13:07 INFO - PROCESS | 2176 | RSS: Main: 294756352 11:13:07 INFO - PROCESS | 2176 | 11:13:09 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50495/tests/kraken/driver.html?testName=imaging-darkroom) 11:13:10 INFO - PROCESS | 2176 | RSS: Main: 335933440 11:13:10 INFO - PROCESS | 2176 | 11:13:13 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50495/tests/kraken/driver.html?testName=imaging-desaturate) 11:13:14 INFO - PROCESS | 2176 | RSS: Main: 337473536 11:13:14 INFO - PROCESS | 2176 | 11:13:16 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50495/tests/kraken/driver.html?testName=json-parse-financial) 11:13:17 INFO - PROCESS | 2176 | RSS: Main: 334741504 11:13:17 INFO - PROCESS | 2176 | 11:13:19 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50495/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:13:19 INFO - PROCESS | 2176 | RSS: Main: 310603776 11:13:19 INFO - PROCESS | 2176 | 11:13:21 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50495/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:13:22 INFO - PROCESS | 2176 | RSS: Main: 315633664 11:13:22 INFO - PROCESS | 2176 | 11:13:24 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50495/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:13:25 INFO - PROCESS | 2176 | RSS: Main: 317341696 11:13:25 INFO - PROCESS | 2176 | 11:13:28 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50495/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:13:29 INFO - PROCESS | 2176 | RSS: Main: 334348288 11:13:29 INFO - PROCESS | 2176 | 11:13:31 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50495/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:13:32 INFO - PROCESS | 2176 | RSS: Main: 327843840 11:13:32 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:50495/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50495/tests/kraken/driver.html?testName=ai-astar) 11:13:34 INFO - PROCESS | 2176 | RSS: Main: 371945472 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | __start_tp_report 11:13:34 INFO - PROCESS | 2176 | _x_x_mozilla_page_load 11:13:34 INFO - PROCESS | 2176 | _x_x_mozilla_page_load_details 11:13:34 INFO - PROCESS | 2176 | |i|pagename|runs| 11:13:34 INFO - PROCESS | 2176 | |0;ai-astar;115;114;117;158;167;114;112;113;113;113 11:13:34 INFO - PROCESS | 2176 | |1;audio-beat-detection;153;115;114;153;115;118;126;113;145;103 11:13:34 INFO - PROCESS | 2176 | |2;audio-dft;184;187;185;186;180;183;184;185;185;184 11:13:34 INFO - PROCESS | 2176 | |3;audio-fft;84;58;58;90;61;60;58;59;74;57 11:13:34 INFO - PROCESS | 2176 | |4;audio-oscillator;93;71;85;70;69;69;83;68;69;83 11:13:34 INFO - PROCESS | 2176 | |5;imaging-gaussian-blur;89;85;90;86;88;85;90;90;88;85 11:13:34 INFO - PROCESS | 2176 | |6;imaging-darkroom;97;98;97;97;97;97;98;98;97;98 11:13:34 INFO - PROCESS | 2176 | |7;imaging-desaturate;88;87;88;86;85;85;85;88;86;85 11:13:34 INFO - PROCESS | 2176 | |8;json-parse-financial;53;55;53;54;55;55;56;54;54;56 11:13:34 INFO - PROCESS | 2176 | |9;json-stringify-tinderbox;70;69;79;75;73;70;71;71;72;71 11:13:34 INFO - PROCESS | 2176 | |10;stanford-crypto-aes;89;90;89;86;86;88;88;88;88;89 11:13:34 INFO - PROCESS | 2176 | |11;stanford-crypto-ccm;151;150;151;150;149;147;153;149;208;174 11:13:34 INFO - PROCESS | 2176 | |12;stanford-crypto-pbkdf2;176;176;173;175;176;176;176;174;176;176 11:13:34 INFO - PROCESS | 2176 | |13;stanford-crypto-sha256-iterative;71;71;70;71;73;83;88;88;81;69 11:13:34 INFO - PROCESS | 2176 | __end_tp_report 11:13:34 INFO - PROCESS | 2176 | __start_cc_report 11:13:34 INFO - PROCESS | 2176 | _x_x_mozilla_cycle_collect,2039 11:13:34 INFO - PROCESS | 2176 | __end_cc_report 11:13:34 INFO - PROCESS | 2176 | __startTimestamp1480446814712__endTimestamp 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | ------- Summary: start ------- 11:13:34 INFO - PROCESS | 2176 | Number of tests: 14 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#0] ai-astar Cycles:10 Average:123.60 Median:114.50 stddev:20.66 (18.0%) stddev-sans-first:21.67 11:13:34 INFO - PROCESS | 2176 | Values: 115.0 114.0 117.0 158.0 167.0 114.0 112.0 113.0 113.0 113.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:122.00 stddev:18.15 (14.9%) stddev-sans-first:16.30 11:13:34 INFO - PROCESS | 2176 | Values: 153.0 115.0 114.0 153.0 115.0 118.0 126.0 113.0 145.0 103.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:1.89 (1.0%) stddev-sans-first:2.00 11:13:34 INFO - PROCESS | 2176 | Values: 184.0 187.0 185.0 186.0 180.0 183.0 184.0 185.0 185.0 184.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#3] audio-fft Cycles:10 Average:65.90 Median:60.50 stddev:12.23 (20.2%) stddev-sans-first:11.08 11:13:34 INFO - PROCESS | 2176 | Values: 84.0 58.0 58.0 90.0 61.0 60.0 58.0 59.0 74.0 57.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:77.00 stddev:9.07 (11.8%) stddev-sans-first:7.24 11:13:34 INFO - PROCESS | 2176 | Values: 93.0 71.0 85.0 70.0 69.0 69.0 83.0 68.0 69.0 83.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:2.17 (2.5%) stddev-sans-first:2.24 11:13:34 INFO - PROCESS | 2176 | Values: 89.0 85.0 90.0 86.0 88.0 85.0 90.0 90.0 88.0 85.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#6] imaging-darkroom Cycles:10 Average:97.40 Median:97.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:13:34 INFO - PROCESS | 2176 | Values: 97.0 98.0 97.0 97.0 97.0 97.0 98.0 98.0 97.0 98.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.50 stddev:1.34 (1.5%) stddev-sans-first:1.27 11:13:34 INFO - PROCESS | 2176 | Values: 88.0 87.0 88.0 86.0 85.0 85.0 85.0 88.0 86.0 85.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.08 (2.0%) stddev-sans-first:1.00 11:13:34 INFO - PROCESS | 2176 | Values: 53.0 55.0 53.0 54.0 55.0 55.0 56.0 54.0 54.0 56.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:71.50 stddev:2.96 (4.1%) stddev-sans-first:3.04 11:13:34 INFO - PROCESS | 2176 | Values: 70.0 69.0 79.0 75.0 73.0 70.0 71.0 71.0 72.0 71.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.50 stddev:1.29 (1.5%) stddev-sans-first:1.32 11:13:34 INFO - PROCESS | 2176 | Values: 89.0 90.0 89.0 86.0 86.0 88.0 88.0 88.0 88.0 89.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#11] stanford-crypto-ccm Cycles:10 Average:158.20 Median:151.00 stddev:19.12 (12.7%) stddev-sans-first:20.10 11:13:34 INFO - PROCESS | 2176 | Values: 151.0 150.0 151.0 150.0 149.0 147.0 153.0 149.0 208.0 174.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:176.00 stddev:1.07 (0.6%) stddev-sans-first:1.12 11:13:34 INFO - PROCESS | 2176 | Values: 176.0 176.0 173.0 175.0 176.0 176.0 176.0 174.0 176.0 176.0 11:13:34 INFO - PROCESS | 2176 | 11:13:34 INFO - PROCESS | 2176 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.50 Median:77.00 stddev:7.66 (10.0%) stddev-sans-first:7.87 11:13:34 INFO - PROCESS | 2176 | Values: 71.0 71.0 70.0 71.0 73.0 83.0 88.0 88.0 81.0 69.0 11:13:34 INFO - PROCESS | 2176 | -------- Summary: end -------- 11:13:34 INFO - PROCESS | 2176 | 11:13:35 INFO - TEST-INFO | 2176: exit 0 11:13:35 INFO - TEST-OK | kraken | took 61074ms 11:13:35 INFO - SUITE-END | took 1181s 11:13:35 INFO - Completed test suite (00:19:41) 11:13:35 INFO - javascript benchmark 11:13:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2643.2334622959343, 3180.6660300668427, 3186.5857438532994, 3208.8716451341948, 3234.385466761315, 5187.610929180308, 5255.86860328492, 5259.5529380002745, 5345.599080068996, 5369.838904832852, 5241.135212689911, 5277.234800953859, 5277.472252774721, 5278.973605131979, 5293.100172970595, 4797.496262892399, 4827.613790896738, 4830.130576496229, 4861.975690121544, 4905.386826646669, 4874.220124780036, 4924.80300787968, 4938.975305123469, 4941.678790878582, 4946.356973593428, 4855.514448555152, 4875.97604503053, 4898.583620392271, 4899.289603007562, 4931.876703082416, 4924.285978533093, 4930.506949305077, 4932.827351042696, 4933.80264789408, 4981.501849814989, 4722.1736196165875, 4779.378680771512, 4788.856334309976, 4865.9026819463415, 4902.558769710743, 5204.76578553966, 5227.947720522784, 5244.108501554745, 5263.02634012705, 5324.440933701944, 4696.647751418657, 5634.915476267859, 5655.0, 5667.518260947824, 5681.545476361881, 5590.8043218487155, 5704.11586204139, 5717.71411429431, 5746.138079288098, 5749.338826034976, 5282.867928301785, 5328.8401347959625, 5340.973295133577, 5342.8664283392445, 5386.757595908115, 5719.170720245625, 5794.362620111784, 5805.506531944832, 5806.390329015477, 5818.33089194748, 5451.018816612968, 5542.0855558832345, 5553.055980483327, 5558.277423934863, 5594.86012849682, 5611.382747897728, 5669.2346533218315, 5684.289463817023, 5714.485696287354, 5791.536677065825, 5597.076482380362, 5651.858703532444, 5654.4062873398525, 5657.9434205658235, 5707.571932105108, 5650.519705824969, 5652.660840349592, 5662.433756624305, 5665.801696940587, 5669.6314739541795, 4540.160070386989, 4593.058423023273, 4594.95405045952, 4597.310403439511, 4642.280446530793, 4161.625453709181, 4162.979185104055, 4183.3515805050265, 4203.600657937491, 4228.0, 5344.706041167696, 5346.7861285548925, 5360.597955153379, 5369.140937449989, 5371.6239863209985, 5591.552675785927, 5634.85912852182, 5650.434956504317, 5660.29246344207, 5704.115862041307, 5311.123664595376, 5352.732363381815, 5368.516833485005, 5374.951884382586, 5389.272448219519, 5037.848864534069, 5044.495550445, 5048.419431765394, 5071.264666623319, 5072.695638261716, 5756.56825738063, 5810.5351571875, 5910.320313163869, 5918.260217472816, 5925.85185370352, 5669.177969194526, 5686.317641883001, 5706.372299047019, 5763.827085187451, 5825.621334613236, 5962.0, 5962.791302304398, 5970.0746384310505, 5978.133170690313, 5995.340512543529, 5497.615166938436, 5617.634853734494, 5660.801871934463, 5666.235058267246, 5680.517156041783, 5550.333959924835, 5574.191742197278, 5632.831015069554, 5748.109043098327, 5753.827385178452, 5517.972410137923, 5539.086050801573, 5547.972260138835, 5551.389347171727, 5551.555875529867, 5533.087040638249, 5540.473655002768, 5544.112941929272, 5559.416261292506, 5566.749496272759, 5356.0626890294825, 5409.441880610044, 5448.891022179613, 5451.727413629382, 5457.290552228185, 5523.6685798852195, 5527.723613819373, 5538.778448862, 5540.667559946416, 5542.916856247079, 5393.164059570773, 5416.8645783854145, 5431.5926305526455, 5432.538234249975, 5436.53789427903], "value": 5258.635529908417, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.61779238882264, 510.7752588860902, 524.0671604543913, 527.2565682387834, 558.8882223555288, 24490.0, 36288.729894453696, 37358.813205934, 37639.62360376392, 39163.41254881179, 38213.42679859804, 38633.0, 38714.80642596783, 38762.03094922628, 38775.44898204068, 8957.10428957104, 9139.497327646977, 9142.0, 9156.26749860013, 9164.221041211506, 8198.098209196984, 8426.410151289381, 8463.0, 8556.743297701049, 8566.742997710078, 10576.576936922515, 10854.511546980404, 10904.236703430763, 11011.779764404708, 11023.559057637725, 10838.349699018045, 10935.83596246057, 10939.781204375948, 10951.780964380669, 10976.506057227443, 8124.715634952749, 8399.874001889977, 10723.249372543925, 10778.946105269424, 10788.56845726178, 29156.12531624055, 29328.160853459154, 29460.70539294601, 35720.28559428823, 36397.27205455876, 3277.885274015398, 3351.413502637053, 3823.560290566593, 3876.604422407931, 4016.2369149861433, 24186.637200442008, 27702.722972770214, 28300.575491367646, 28441.57337639937, 28717.712822871923, 3106.301082256497, 3114.2370119320685, 3174.9682503175136, 3180.157258326545, 3182.618085829692, 422744.0, 434157.8292108519, 435925.0, 436144.0, 437553.9999999968, 59245.0, 60409.09386359208, 60524.697376512835, 60544.69727651333, 60601.0, 62725.0, 63784.0, 64207.03689444662, 64342.0, 64404.67797660982, 13883.514077007256, 14347.85652143486, 14357.928210358881, 14362.281885905872, 14376.568702938928, 10542.631007914686, 10769.515371808131, 10846.0, 10876.891231087588, 10886.891131088747, 15453.845461545465, 17208.569785755455, 17223.0, 17360.218790154475, 18588.349407770664, 7934.801629959182, 8241.426008565304, 8256.25693687559, 8258.298044666151, 8378.49729016261, 813.6175997281268, 829.5064436660177, 917.5320586500933, 932.5943214701626, 976.8485884687884, 25739.742602574108, 27746.861265693948, 27783.859985902673, 28240.43519129647, 28340.43319133647, 1004.2719028704131, 1037.1391744851755, 1040.2198351236573, 1070.4861666400172, 1092.2463500184847, 14065.367058482392, 14164.291785410689, 14222.359993800304, 14580.781288280685, 14657.780133298009, 555228.0, 561109.0, 562459.0, 562897.0, 566127.0, 52373.214401784004, 52657.73671131697, 52845.471545284825, 52855.73572132115, 53069.0, 1306.9085164038427, 1358.7078778062764, 1368.1790925444654, 1368.8015237790266, 1370.1436602123672, 24507.877460612584, 24756.628650569895, 26634.334141646614, 26973.0, 27461.782261370277, 33264.66735332616, 36211.637883620824, 44862.0, 44880.32679509875, 44958.0, 519909.0, 523511.0, 524206.0, 525829.0, 527183.0, 25125.87437062876, 25262.74737252604, 25656.743432565436, 25683.486330273663, 25701.10046148376, 40839.59160408358, 41990.58009419989, 42663.7866810664, 42832.78583607062, 43083.569164307955, 35147.472787908715, 35407.29185416226, 35457.0, 36541.08647283839, 36874.262514750095, 34808.0, 34854.0, 35620.0, 35822.28355432825, 36121.91634250872, 32595.34809303848, 34110.65889341174, 35528.111797205274, 35603.46594801132, 35870.461943071394, 30463.695363046085, 31677.8416107918, 31833.5224971621, 31848.52227216547, 31972.36055278835, 23410.64884026707, 23451.06195752151, 23559.41101472477, 23872.761272387055, 23982.40043998914], "value": 18762.735947576304, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.0849228314262, 360.52050772472614, 366.45581311752045, 373.527487728024, 392.60150946789014, 14577.271136443189, 14963.700725985474, 15570.29933652984, 19620.509487262825, 20083.89958050208, 18135.0, 19163.137658805354, 19227.94336662764, 19264.614707705838, 19414.611707765835, 5597.692126933017, 5785.450382213704, 5785.479306862381, 5810.738516766755, 5921.851953701149, 4644.303354496818, 5579.082326430701, 5871.911921321183, 5910.763569457216, 5913.940860591403, 5002.399712034561, 5825.126231065353, 5867.7066146692705, 5872.354041055481, 5877.177195192677, 5523.7790488380415, 5776.855578610526, 5823.242978412779, 5826.446487583673, 5826.941730582682, 4847.975760121212, 5084.084864724348, 5099.872503187413, 5100.336956195708, 5107.61692873036, 23976.640350394584, 24656.0137594496, 24684.889179986763, 25090.623640645405, 25194.748052519422, 2346.4016675747744, 2378.63131214662, 2471.3821544613847, 2659.6941351744604, 2771.1686494051905, 15119.924400378037, 15154.090754554652, 15276.236188190545, 15673.608159795982, 15912.681746365124, 1654.2225154177518, 1800.2438975630137, 1817.391173956713, 1825.4067428085793, 1866.430738624719, 88223.0, 103650.48174759078, 115391.0, 115493.69012619785, 116508.25237621443, 10470.528826202839, 10568.735781605521, 10726.463676816127, 10794.974477424632, 10933.234673572773, 13479.460821567027, 13482.0, 13491.662708432368, 13498.122622029538, 13530.458781648624, 7172.390346820474, 7636.579988100708, 7814.6874125034365, 7901.209879012168, 7945.48354356965, 7605.277498637621, 7616.04799400075, 7636.69453221876, 7801.609919504002, 7807.258310460497, 6372.267189273293, 6495.577787443801, 6514.120593719787, 6520.347965203442, 6620.602763834089, 1774.5297496163528, 1820.7633007708912, 1825.2607693884, 1825.361123606727, 1833.3766519383473, 948.5541795356172, 970.403202030746, 1000.5197505197546, 1003.4932359158724, 1059.56557811297, 20653.76077435359, 21694.674579881314, 21752.02115904788, 21770.564588708137, 21854.453638658844, 850.2475309351269, 882.1795729971188, 894.7718331825342, 957.3681370295571, 992.6426486464867, 6895.620740859201, 11422.200445968703, 11564.074874010059, 11601.361925094032, 11602.6519204424, 510137.0, 511418.0, 513721.0, 522975.0, 524810.0, 82499.3500129994, 106739.39890901643, 107288.46355768171, 113838.0, 116793.41603292098, 872.4372779557277, 887.9822403551893, 943.4433684126399, 998.8951160128228, 1003.4079892863246, 18642.0, 19002.42992710221, 19112.808871911104, 19139.86555713844, 19177.137028834015, 47855.76072119617, 48522.5147748518, 48988.510114898396, 49264.75367623139, 50200.49799502104, 67785.32214677791, 68370.65814671094, 68457.0, 70312.0, 70927.0, 7844.686212551434, 7856.882146767689, 8178.3457323412795, 8348.373871959506, 8355.874661879956, 11614.303141811519, 12594.055445841415, 12621.495140194289, 13036.152650077714, 13111.868881311446, 8752.431091979, 11144.832827507757, 11240.662780116609, 11279.32324060559, 11410.429478526206, 10519.631812886511, 10802.72993175177, 11005.61480348184, 11237.101031917264, 11326.433678316216, 11217.887821121685, 11468.42462933492, 11567.884321157017, 11590.826137608112, 11706.76586468283, 7826.373890088666, 7923.445358824827, 8333.208345207195, 8338.499690018618, 8362.623681934449, 10096.646617368357, 11106.888931110585, 11351.432428378714, 11397.886021140013, 11445.370504621993], "value": 9389.664395472146, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.1380681846572, 1443.1701771481398, 1478.889083318751, 1625.2686291168977, 1838.4392760208138, 7474.626268686564, 7816.491928024674, 7820.217978202177, 7824.100228473721, 7827.178146294643, 7898.249666281708, 8192.50844949302, 8213.301869341098, 8313.792155196123, 8314.0, 1936.9225230990778, 2316.143027079983, 2319.8840057997118, 2320.0487800002, 2321.872297023663, 2034.7253120828648, 2121.893905304736, 2269.7503274639776, 2326.9418264543438, 2337.030132495021, 2060.4333808202714, 2222.7777222277805, 2311.3528212100637, 2312.4912519245822, 2314.8379613426982, 2257.7177852768405, 2290.0725206291563, 2290.874001929893, 2295.8278129140213, 2307.849989750661, 2017.1326329678232, 2091.843111766608, 2094.8428867834823, 2252.6958860553777, 2289.095807156181, 8043.798905027421, 8293.83412331756, 8298.170182981714, 8390.580470976427, 8409.32725381968, 4983.152864013126, 5137.12668846297, 5146.176611742141, 5149.845504634867, 5149.922751158698, 3395.847186876572, 3437.123533498967, 3444.19061520545, 3489.2498112905846, 3528.188516641161, 921.4885738415177, 1040.7242080848582, 1050.2648146297545, 1059.4861492176287, 1084.6583326252205, 10641.627543036035, 10666.986636269541, 10736.78526429475, 10796.406197659126, 10806.78386432267, 4354.346847972829, 4493.168763778712, 4590.517995610479, 4592.448906131285, 4678.532146785362, 9314.161725444743, 9333.020032896584, 9351.579178936965, 9353.766155846159, 9355.625774969061, 5106.514881086291, 5110.565601923804, 5111.923321150186, 5115.104856650071, 5131.050755610224, 4500.594946454835, 4639.443266808004, 4698.859034228979, 4712.198926182557, 4723.905521889543, 3694.3165514379925, 3715.331240376758, 3737.9626203738158, 3766.1902690921584, 3801.3157631626573, 1211.9091068169923, 1212.9757404851853, 1215.6596153077153, 1225.2832093225384, 1229.4037391864938, 762.2415696382135, 769.9615019249015, 779.1974266505508, 806.846699127164, 879.0533576468652, 5255.264263003182, 5376.704281264568, 5458.372287187024, 5492.368377636543, 5548.223248745179, 410.3536929336307, 426.6373582454888, 434.36799456790294, 437.5078037208141, 439.6351028646216, 3154.4322022036254, 3345.1302661308237, 3530.4174811156386, 3698.1679122197293, 3755.605661405568, 9167.587458564381, 9610.711678649652, 9612.567434465465, 9613.951930240304, 9635.807283854283, 9803.264755143393, 9811.656592019388, 10113.797724045478, 10137.64518241858, 10149.391036537683, 7621.428392870557, 7894.802629934297, 7896.131425543185, 7898.9210107899335, 7911.327537159175, 5151.871203219949, 5517.779288828562, 5529.33647962231, 5585.888282234414, 5619.466150715675, 9167.44995300284, 9193.494357810385, 9314.115159059878, 9399.10708482693, 9443.480608566595, 8915.910840891507, 9455.385399948982, 9488.430694158373, 9505.001974792547, 9563.474008929297, 7007.948807678889, 7032.929670703227, 7107.786766397016, 7119.786406407816, 7123.501354905314, 7765.107012693613, 7801.804954876174, 7815.452918295665, 7893.0, 7896.249856263876, 7039.507234493536, 7067.0, 7094.787156385317, 7116.50184487081, 7285.672144753393, 6983.057287266154, 6998.475114366341, 7032.050673159058, 7037.049998250375, 7091.645417729196, 6557.2131344239, 6608.603483790988, 6649.767258145942, 6725.529212955046, 6752.966235168793, 4731.929021064618, 4751.358566593465, 4788.257820037899, 4802.663813533159, 4978.079055374767, 4825.879353016062, 4895.216765317532, 4902.338184345068, 4957.801687932587, 4960.851174464772], "value": 4247.232592226689, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.9165833566602, 297.93594377208905, 306.62438512821797, 312.2178941750914, 313.3998393077257, 4555.498895121534, 4631.661011189349, 5036.52153045461, 5215.374155101388, 5224.2163675448655, 4944.431390390107, 5105.259737338084, 5136.330692524925, 5157.819476318329, 5222.843314700555, 3993.2412841560085, 4037.6971727120435, 4055.9797201013953, 4063.4920634920636, 4094.7133700640966, 4025.859094931678, 4043.614267582126, 4046.7571945683208, 4052.837886484537, 4077.3476243800997, 2897.579850921615, 3424.5376874121926, 3829.770213787168, 3975.423563583279, 4005.379166229239, 3943.653526151935, 3957.960420395788, 3976.2445135424177, 3979.323515002442, 3981.8145483613284, 3457.3258214648154, 3457.827108644583, 3457.930841383158, 3458.792472451661, 3463.8960831175104, 4069.4506241657296, 4472.418585583853, 5038.874028149289, 5092.541671249568, 5108.310378098983, 3767.4913886625227, 4472.508024117345, 4488.124815660947, 4491.932621010687, 4501.617362524189, 4776.522347765195, 5484.382107278362, 5485.341758988907, 5502.422245664187, 5530.253415788858, 3405.863765449379, 3532.3994920863515, 3613.8012409317475, 3751.874437668716, 3763.7929913854728, 5387.542058924996, 5657.632253903483, 5673.999999999959, 5711.485966263056, 5773.769049238025, 3178.4278829810855, 3816.1491676536857, 3816.484774555455, 3828.291766023239, 3841.2893614680816, 3886.047918259988, 3891.0, 3898.3762597984187, 3898.4542164097047, 3905.9218815624095, 3762.2287431076566, 4386.539413361615, 4476.507584165739, 4477.522417602184, 4540.455145382575, 5123.615728820353, 5408.215808707715, 5489.917651235235, 5514.711394771205, 5530.469530469531, 1184.5311813351382, 1207.4204381896564, 1214.678110300771, 1238.4984081447028, 1253.4422182128865, 762.5615271219071, 787.6258777080841, 819.6844214977276, 819.8852160697508, 839.5340585974842, 4227.852025179165, 4646.95353046472, 4892.28186578196, 4920.31115643803, 4948.406191257072, 4379.700657155019, 5346.4118946915805, 5348.8662783429945, 5360.973195133999, 5431.474364420564, 4876.853694389174, 5261.106391484668, 5318.627696061239, 5326.893462130735, 5335.078717142975, 2516.7231604523486, 2671.4389978104427, 2838.4606924684244, 2846.6299381080325, 2850.572414137896, 5238.97380513095, 5280.498352656491, 5601.759296281439, 5620.91568626471, 5623.353314368818, 4803.207470767354, 4844.709317440965, 4978.158081509792, 5579.972100139555, 5604.635698679573, 5585.519837243215, 5596.285801386324, 5605.495505404451, 5606.439356064361, 5615.354234263031, 4803.678988278251, 4946.851594452172, 5313.442088580643, 5350.919736203882, 5421.701806400528, 5245.527902488794, 5652.382475215947, 5663.603547751783, 5705.914411283751, 5708.8572785679025, 5608.364068887617, 5721.312212897288, 5918.437748413894, 5944.078667806497, 5954.642721436728, 3422.7775194612273, 3760.266747984117, 3770.45328427371, 3822.0, 3882.4758657581997, 4749.4063242094735, 4749.430068391815, 5669.149627555899, 5689.54483641316, 5709.571782116275, 4878.438979517259, 5152.381714194171, 5529.944700552943, 5562.972185139049, 5572.4706152915405, 4850.854474365775, 5517.806876759294, 5574.442555744393, 5575.0, 5596.608237423504, 5192.324997750419, 5322.680639161508, 5343.732813359239, 5460.781568737365, 5576.804811831566, 4876.487968763229, 5282.751108068587, 5542.750576223999, 5552.639078459887, 5575.0, 4748.382710247645, 4778.20475022116, 5144.768485418091, 5388.326459192601, 5424.0], "value": 3973.901289853678, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.9861002779944, 719.3813320544334, 731.5025782467922, 765.3953376832303, 766.1036587192983, 13896.791548126786, 14608.561743147697, 14620.195889226088, 14621.12273263605, 14631.487897923575, 12795.0, 12878.80681789774, 12893.613191604243, 12914.483420663162, 12933.094683372168, 646.0728854094377, 674.0798809624852, 677.2211956250302, 794.9761507154794, 818.2880893622556, 821.9260266576007, 836.8284501677172, 838.8154605986673, 839.3495041342946, 839.8488272111017, 885.4864178776327, 885.6723012485389, 886.0563499872648, 886.6852267445029, 886.7384121684119, 673.8147009572358, 697.1285892634207, 701.1060897355861, 881.3169793410126, 881.7839629290864, 519.5531842615347, 519.7531172692978, 615.1910238036967, 639.1882309466997, 642.4025656139788, 12801.231926084465, 12823.0, 12830.101892867502, 12836.871631283755, 12917.418716157796, 10849.566017359375, 12678.87321126786, 12737.936310318482, 12825.294608796512, 13171.934140329333, 9740.853887191697, 9908.306418550632, 10020.498975051218, 10061.19510439163, 10072.647457339031, 4219.451471308741, 4278.315469524892, 4292.527821939584, 4378.671599630041, 4381.890452738675, 99939.0, 103256.48371758094, 103734.0, 104437.0, 104506.47746761293, 8391.748247552583, 10039.69880903574, 10079.748006299902, 10110.545025473872, 10461.633842815465, 20090.799092008892, 20349.08429120693, 20375.59248815045, 20405.0, 20653.070611822503, 7223.458240631973, 7265.237150099163, 7301.269873012762, 7438.144613369532, 7467.439942004371, 4001.419794129893, 4066.959330406658, 4140.130572579732, 4208.190517702568, 4226.1336426032585, 3251.1872031992, 3316.701496865294, 3368.2589830237307, 3380.5436266104252, 3380.5436266104252, 608.5223099866583, 616.7255571270831, 627.4039662320813, 628.8239292997968, 631.1227393922452, 509.9291487875506, 527.604296777417, 533.5438200338732, 592.4431034827248, 614.5728718540661, 7883.36933045355, 8339.041010283774, 8486.702965396305, 8499.70251041223, 8756.12438756132, 509.53377659441196, 558.020673717623, 570.2700543304577, 589.0927970924813, 635.5551114220065, 4122.237386083584, 4152.875413737593, 4343.978280108642, 4482.798274077674, 4537.241119119949, 100905.0, 101171.0, 102331.48834255782, 102873.48563257136, 105344.0, 76683.61658191784, 87480.0, 89248.5537572308, 92867.0, 92969.0, 81248.0, 83130.58434707788, 83142.0, 83566.0, 87868.12131878728, 8388.203120703523, 8470.237678608955, 8549.187827156411, 8597.0, 8779.956100219713, 40758.0, 52045.0, 52239.73880130575, 52667.68330791761, 53291.0, 59417.81164376602, 67442.3255767436, 69205.3079469219, 69208.0, 70012.94980575194, 9723.222142228746, 9725.367851089657, 9730.659426920023, 9784.412935223909, 10172.84740728875, 9726.31915765918, 11932.0, 11980.520779169085, 12296.323702196107, 12585.119041667362, 11508.712282192677, 11844.585439509576, 11864.703382415508, 11888.04895608332, 12095.879041209828, 11810.468528916048, 11824.290542567473, 11886.227395219283, 11899.226550274205, 11947.10396720232, 11107.666769996913, 11450.0, 11571.710707232387, 11629.418529073344, 12084.45619947122, 9579.473128977974, 9882.703518894445, 10037.69886903394, 10076.84884726715, 10110.44392558387, 9382.718518444457, 10029.097381235724, 10036.849447258151, 10048.296619236584, 10061.0], "value": 6873.932591718569, "unit": "score"}], "name": "dromaeo_css", "value": 6895.50507835859, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 117.0, 158.0, 167.0, 114.0, 112.0, 113.0, 113.0, 113.0], "value": 123.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 115.0, 114.0, 153.0, 115.0, 118.0, 126.0, 113.0, 145.0, 103.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 185.0, 186.0, 180.0, 183.0, 184.0, 185.0, 185.0, 184.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 58.0, 90.0, 61.0, 60.0, 58.0, 59.0, 74.0, 57.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 71.0, 85.0, 70.0, 69.0, 69.0, 83.0, 68.0, 69.0, 83.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 90.0, 86.0, 88.0, 85.0, 90.0, 90.0, 88.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 97.0, 97.0, 97.0, 98.0, 98.0, 97.0, 98.0], "value": 97.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 86.0, 85.0, 85.0, 85.0, 88.0, 86.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 54.0, 55.0, 55.0, 56.0, 54.0, 54.0, 56.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 79.0, 75.0, 73.0, 70.0, 71.0, 71.0, 72.0, 71.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 89.0, 86.0, 86.0, 88.0, 88.0, 88.0, 88.0, 89.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 149.0, 147.0, 153.0, 149.0, 208.0, 174.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 173.0, 175.0, 176.0, 176.0, 176.0, 174.0, 176.0, 176.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 71.0, 73.0, 83.0, 88.0, 88.0, 81.0, 69.0], "value": 76.5, "unit": "score"}], "name": "kraken", "value": 1471.4, "alertThreshold": 2.0}]} 11:13:35 INFO - Return code: 0 11:13:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:13:36 INFO - # TBPL SUCCESS # 11:13:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:13:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:13:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:13:36 INFO - 2016-11-29 11:13:36.019 screenresolution[2180:18706] starting screenresolution argv=screenresolution get 11:13:36 INFO - 2016-11-29 11:13:36.023 screenresolution[2180:18706] Display 0: 1600x1200x32@60 11:13:36 INFO - 2016-11-29 11:13:36.030 screenresolution[2181:18709] starting screenresolution argv=screenresolution list 11:13:36 INFO - Available Modes on Display 0 11:13:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:13:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:13:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:13:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:13:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:13:36 INFO - Intel Iris: 11:13:36 INFO - Chipset Model: Intel Iris 11:13:36 INFO - Type: GPU 11:13:36 INFO - Bus: Built-In 11:13:36 INFO - VRAM (Dynamic, Max): 1536 MB 11:13:36 INFO - Vendor: Intel (0x8086) 11:13:36 INFO - Device ID: 0x0a2e 11:13:36 INFO - Revision ID: 0x0009 11:13:36 INFO - Displays: 11:13:36 INFO - Display: 11:13:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:13:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:13:36 INFO - Display Serial Number: 1600x1200 60 11:13:36 INFO - Main Display: Yes 11:13:36 INFO - Mirror: Off 11:13:36 INFO - Online: Yes 11:13:36 INFO - Rotation: Supported 11:13:36 INFO - Return code: 0 11:13:36 INFO - Running post-action listener: _resource_record_post_action 11:13:36 INFO - [mozharness: 2016-11-29 19:13:36.283979Z] Finished run-tests step (success) 11:13:36 INFO - Running post-run listener: _resource_record_post_run 11:13:36 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 1413120; Write bytes: 694146560; Read time: 12; Write time: 2124 11:13:36 INFO - TinderboxPrint: CPU usage
53.8% 11:13:36 INFO - TinderboxPrint: I/O read bytes / time
1,413,120 / 12 11:13:36 INFO - TinderboxPrint: I/O write bytes / time
694,146,560 / 2,124 11:13:36 INFO - TinderboxPrint: CPU idle
2,246.8 (46.2%) 11:13:36 INFO - TinderboxPrint: CPU system
978.9 (20.1%) 11:13:36 INFO - TinderboxPrint: CPU user
1,636.0 (33.7%) 11:13:36 INFO - TinderboxPrint: Swap in / out
384,172,032 / 0 11:13:36 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 384455168; Write bytes: 387426304; Read time: 28997; Write time: 908 11:13:36 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 491520; Write bytes: 305364480; Read time: 7; Write time: 1210 11:13:36 INFO - Running post-run listener: _upload_blobber_files 11:13:36 INFO - Blob upload gear active. 11:13:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:13:36 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 11:13:36 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:13:36 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:13:37 INFO - (blobuploader) - INFO - Open directory for files ... 11:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:13:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:37 INFO - (blobuploader) - INFO - Done attempting. 11:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:39 INFO - (blobuploader) - INFO - Done attempting. 11:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:13:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:41 INFO - (blobuploader) - INFO - Done attempting. 11:13:41 INFO - (blobuploader) - INFO - Iteration through files over. 11:13:41 INFO - Return code: 0 11:13:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:13:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:13:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3eeede1f7cccd330e71c8ee284b0fe18ce313aff02632a1e59db0049117d12e7706d21a33f45edc3f7c82e7e543b71031af4c8bd457c35d642a2b9f8e43be74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/62b45ef7447ed289835528561e3ae1e66379d168810f7306de07d96de7647dc76ec60448697c0c63cd631f63a7fa01fe8d3398ac349a22471c23ae148030b387", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/dc521176facb28920d0c3111bff4e6420910e80b9c3b5ff3c79ec20685bf54d1dd47c62d060498002bd01bf62d883f5cede8a5c2f0eac513ba712eac94027c26"} 11:13:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:13:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:13:41 INFO - Contents: 11:13:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3eeede1f7cccd330e71c8ee284b0fe18ce313aff02632a1e59db0049117d12e7706d21a33f45edc3f7c82e7e543b71031af4c8bd457c35d642a2b9f8e43be74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/62b45ef7447ed289835528561e3ae1e66379d168810f7306de07d96de7647dc76ec60448697c0c63cd631f63a7fa01fe8d3398ac349a22471c23ae148030b387", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/dc521176facb28920d0c3111bff4e6420910e80b9c3b5ff3c79ec20685bf54d1dd47c62d060498002bd01bf62d883f5cede8a5c2f0eac513ba712eac94027c26"} 11:13:41 INFO - Running post-run listener: copy_logs_to_upload_dir 11:13:41 INFO - Copying logs to upload dir... 11:13:41 INFO - mkdir: /builds/slave/test/build/upload/logs 11:13:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.447331 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-29 11:13:41.704647) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 11:13:41.708324) ========= 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.argJvf95jl/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.GbY65q7S80/Listeners TMPDIR=/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3eeede1f7cccd330e71c8ee284b0fe18ce313aff02632a1e59db0049117d12e7706d21a33f45edc3f7c82e7e543b71031af4c8bd457c35d642a2b9f8e43be74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/62b45ef7447ed289835528561e3ae1e66379d168810f7306de07d96de7647dc76ec60448697c0c63cd631f63a7fa01fe8d3398ac349a22471c23ae148030b387", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/dc521176facb28920d0c3111bff4e6420910e80b9c3b5ff3c79ec20685bf54d1dd47c62d060498002bd01bf62d883f5cede8a5c2f0eac513ba712eac94027c26"} build_url:https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/BMH9SQvQTyqpVOTNjEVASw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3eeede1f7cccd330e71c8ee284b0fe18ce313aff02632a1e59db0049117d12e7706d21a33f45edc3f7c82e7e543b71031af4c8bd457c35d642a2b9f8e43be74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/62b45ef7447ed289835528561e3ae1e66379d168810f7306de07d96de7647dc76ec60448697c0c63cd631f63a7fa01fe8d3398ac349a22471c23ae148030b387", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/dc521176facb28920d0c3111bff4e6420910e80b9c3b5ff3c79ec20685bf54d1dd47c62d060498002bd01bf62d883f5cede8a5c2f0eac513ba712eac94027c26"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 11:13:41.742730) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 11:13:41.743065) ========= 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.argJvf95jl/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.GbY65q7S80/Listeners TMPDIR=/var/folders/g3/g2lxvbfd1c33ggtssv6lgc3r00000w/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.005344 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 11:13:41.791845) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 11:13:41.792166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 11:13:41.792482) ========= ========= Total master_lag: 0.18 =========