builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0126 starttime: 1479397027.2 results: success (0) buildid: 20161117053428 builduid: 1657d44efd5749e8abff18222fa506b3 revision: 0005d0bfadf72746ce36f4e8d09d9504b814557e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 07:37:07.196397) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 07:37:07.196821) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 07:37:07.197096) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 07:37:07.221275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:37:07.221534) ========= 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.ULpxVTLECD/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.3Txqw2OpSi/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-17 07:37:07-- 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% 49.0M=0s 2016-11-17 07:37:07 (49.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097344 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:37:07.340625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:37:07.340907) ========= 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.ULpxVTLECD/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.3Txqw2OpSi/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.026477 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:37:07.391527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 07:37:07.391831) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0005d0bfadf72746ce36f4e8d09d9504b814557e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0005d0bfadf72746ce36f4e8d09d9504b814557e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ULpxVTLECD/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.3Txqw2OpSi/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-17 07:37:07,490 truncating revision to first 12 chars 2016-11-17 07:37:07,490 Setting DEBUG logging. 2016-11-17 07:37:07,490 attempt 1/10 2016-11-17 07:37:07,490 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0005d0bfadf7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 07:37:08,366 unpacking tar archive at: mozilla-central-0005d0bfadf7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.201436 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 07:37:08.617559) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 07:37:08.617876) ========= script_repo_revision: 0005d0bfadf72746ce36f4e8d09d9504b814557e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 07:37:08.621285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 07:37:08.621566) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 07:37:08.639755) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-11-17 07:37:08.640024) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ULpxVTLECD/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.3Txqw2OpSi/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 07:37:08 INFO - MultiFileLogger online at 20161117 07:37:08 in /builds/slave/test 07:37:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:37:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:08 INFO - {'append_to_log': False, 07:37:08 INFO - 'base_work_dir': '/builds/slave/test', 07:37:08 INFO - 'blob_upload_branch': 'Firefox', 07:37:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:08 INFO - 'branch': 'Firefox', 07:37:08 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:08 INFO - 'config_files': ('talos/mac_config.py',), 07:37:08 INFO - 'default_actions': ('clobber', 07:37:08 INFO - 'read-buildbot-config', 07:37:08 INFO - 'download-and-extract', 07:37:08 INFO - 'populate-webroot', 07:37:08 INFO - 'create-virtualenv', 07:37:08 INFO - 'install', 07:37:08 INFO - 'run-tests'), 07:37:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:08 INFO - 'download_minidump_stackwalk': True, 07:37:08 INFO - 'download_symbols': 'ondemand', 07:37:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:08 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:08 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:08 INFO - 'installer_path': 'installer.exe', 07:37:08 INFO - 'log_level': 'info', 07:37:08 INFO - 'log_name': 'talos', 07:37:08 INFO - 'log_to_console': True, 07:37:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:37:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:37:08 INFO - 'opt_config_files': (), 07:37:08 INFO - 'pip_index': False, 07:37:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:37:08 INFO - 'cmd': ('bash', 07:37:08 INFO - '-c', 07:37:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:37:08 INFO - 'enabled': True, 07:37:08 INFO - 'halt_on_failure': False, 07:37:08 INFO - 'name': 'check_screen_resolution'},), 07:37:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:37:08 INFO - 'cmd': ('bash', 07:37:08 INFO - '-c', 07:37:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:37:08 INFO - 'enabled': True, 07:37:08 INFO - 'halt_on_failure': False, 07:37:08 INFO - 'name': 'check_screen_resolution'},), 07:37:08 INFO - 'run_cmd_checks_enabled': True, 07:37:08 INFO - 'sps_profile': False, 07:37:08 INFO - 'sps_profile_interval': 0, 07:37:08 INFO - 'suite': 'dromaeojs-e10s', 07:37:08 INFO - 'system_bits': '32', 07:37:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:08 INFO - 'title': 't-yosemite-r7-0126', 07:37:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:08 INFO - 'use_talos_json': True, 07:37:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:08 INFO - 'work_dir': 'build'} 07:37:08 INFO - [mozharness: 2016-11-17 15:37:08.847998Z] Running clobber step. 07:37:08 INFO - Running pre-action listener: _resource_record_pre_action 07:37:08 INFO - Running main action method: clobber 07:37:08 INFO - rmtree: /builds/slave/test/build 07:37:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:11 INFO - Running post-action listener: _resource_record_post_action 07:37:11 INFO - [mozharness: 2016-11-17 15:37:11.295226Z] Finished clobber step (success) 07:37:11 INFO - [mozharness: 2016-11-17 15:37:11.295423Z] Running read-buildbot-config step. 07:37:11 INFO - Running pre-action listener: _resource_record_pre_action 07:37:11 INFO - Running main action method: read_buildbot_config 07:37:11 INFO - Using buildbot properties: 07:37:11 INFO - { 07:37:11 INFO - "project": "", 07:37:11 INFO - "product": "firefox", 07:37:11 INFO - "script_repo_revision": "production", 07:37:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:37:11 INFO - "repository": "", 07:37:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:37:11 INFO - "buildid": "20161117053428", 07:37:11 INFO - "pgo_build": "False", 07:37:11 INFO - "basedir": "/builds/slave/test", 07:37:11 INFO - "buildnumber": 169, 07:37:11 INFO - "slavename": "t-yosemite-r7-0126", 07:37:11 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:37:11 INFO - "platform": "yosemite_r7", 07:37:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:37:11 INFO - "branch": "mozilla-central", 07:37:11 INFO - "repo_path": "mozilla-central", 07:37:11 INFO - "revision": "0005d0bfadf72746ce36f4e8d09d9504b814557e", 07:37:11 INFO - "stage_platform": "macosx64", 07:37:11 INFO - "builduid": "1657d44efd5749e8abff18222fa506b3", 07:37:11 INFO - "slavebuilddir": "test" 07:37:11 INFO - } 07:37:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:37:11 INFO - Running post-action listener: _resource_record_post_action 07:37:11 INFO - [mozharness: 2016-11-17 15:37:11.298812Z] Finished read-buildbot-config step (success) 07:37:11 INFO - [mozharness: 2016-11-17 15:37:11.298891Z] Running download-and-extract step. 07:37:11 INFO - Running pre-action listener: _resource_record_pre_action 07:37:11 INFO - Running main action method: download_and_extract 07:37:11 INFO - mkdir: /builds/slave/test/build/tests 07:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:11 INFO - trying https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:37:11 INFO - Downloading https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/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 07:37:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/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 07:37:12 INFO - Downloaded 1199 bytes. 07:37:12 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:37:12 INFO - Using the following test package requirements: 07:37:12 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:37:12 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:12 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:37:12 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:12 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:37:12 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:12 INFO - u'jsshell-mac.zip'], 07:37:12 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:12 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:37:12 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:37:12 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:12 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:37:12 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:12 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:37:12 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:12 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:37:12 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:37:12 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:37:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:37:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:37:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:37:12 INFO - Fetch https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:37:12 INFO - Http code: 200 07:37:12 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 07:37:12 INFO - x-amz-cf-id: PjVqtp9Wc0QDCIAAfgq0aPYtBYBIMAi_EJjbuwbQOdfe6GxNrlONdw== 07:37:12 INFO - x-amz-version-id: MlHAQOPs.fwaGoEnKXHZ0uPCHyMWvOnL 07:37:13 INFO - Expected file size: 16273358 07:37:13 INFO - Obtained file size: 16273358 07:37:19 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 07:37:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:37:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:37:19 INFO - Fetch https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:37:20 INFO - Http code: 200 07:37:20 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 07:37:20 INFO - x-amz-cf-id: 6RZjgz2uvjiBOysiYd2SKilpY2hwzdKWEQHUTlluYRyaxX9WiWB0lw== 07:37:20 INFO - x-amz-version-id: MlHAQOPs.fwaGoEnKXHZ0uPCHyMWvOnL 07:37:20 INFO - Expected file size: 16273358 07:37:20 INFO - Obtained file size: 16273358 07:37:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:37:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:37:27 INFO - Fetch https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:37:28 INFO - Http code: 200 07:37:28 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 07:37:28 INFO - x-amz-cf-id: Zj-04ILfwb0PJGN9zvS5nABT33Te4mSgfGbi2j_FoZ2QtSKe2BVvog== 07:37:28 INFO - x-amz-version-id: gp3WSxdGJY4f6RVvTMw4pyX6d1O970AK 07:37:28 INFO - Expected file size: 14409392 07:37:28 INFO - Obtained file size: 14409392 07:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:28 INFO - trying https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:37:28 INFO - Downloading https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:37:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/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 07:37:31 INFO - Downloaded 110976667 bytes. 07:37:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:37:31 INFO - mkdir: /builds/slave/test/properties 07:37:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:31 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:31 INFO - Contents: 07:37:31 INFO - build_url:https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:37:32 INFO - Running post-action listener: _resource_record_post_action 07:37:32 INFO - Running post-action listener: set_extra_try_arguments 07:37:32 INFO - [mozharness: 2016-11-17 15:37:32.348763Z] Finished download-and-extract step (success) 07:37:32 INFO - [mozharness: 2016-11-17 15:37:32.348908Z] Running populate-webroot step. 07:37:32 INFO - Running pre-action listener: _resource_record_pre_action 07:37:32 INFO - Running main action method: populate_webroot 07:37:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:32 INFO - '--tppagecycles', 07:37:32 INFO - '7'], 07:37:32 INFO - 'tests': ['tsvgm']}}, 07:37:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:37:32 INFO - 'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:37:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:37:32 INFO - 'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['damp', 'tps']}, 07:37:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:37:32 INFO - 'tests': ['damp', 'tps']}, 07:37:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['dromaeo_dom']}, 07:37:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['basic_compositor_video']}, 07:37:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:37:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['a11yr', 07:37:32 INFO - 'ts_paint', 07:37:32 INFO - 'tpaint', 07:37:32 INFO - 'sessionrestore', 07:37:32 INFO - 'sessionrestore_no_auto_restore', 07:37:32 INFO - 'tabpaint']}, 07:37:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['tsvgx', 07:37:32 INFO - 'tsvgr_opacity', 07:37:32 INFO - 'tart', 07:37:32 INFO - 'tscrollx', 07:37:32 INFO - 'cart']}, 07:37:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:32 INFO - 'tsvgr_opacity', 07:37:32 INFO - 'tart', 07:37:32 INFO - 'tscrollx', 07:37:32 INFO - 'cart']}, 07:37:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:37:32 INFO - 'talos_options': ['--disable-e10s'], 07:37:32 INFO - 'tests': ['tp5o']}, 07:37:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:37:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:37:32 INFO - 'talos_options': ['--disable-e10s', 07:37:32 INFO - '--xperf_path', 07:37:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:32 INFO - 'tests': ['tp5n']}, 07:37:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:37:32 INFO - 'talos_options': ['--xperf_path', 07:37:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:32 INFO - 'tests': ['tp5n']}}, 07:37:32 INFO - 'talos.zip': {'path': '', 07:37:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:32 INFO - Running post-action listener: _resource_record_post_action 07:37:32 INFO - [mozharness: 2016-11-17 15:37:32.367098Z] Finished populate-webroot step (success) 07:37:32 INFO - [mozharness: 2016-11-17 15:37:32.367231Z] Running create-virtualenv step. 07:37:32 INFO - Running pre-action listener: _resource_record_pre_action 07:37:32 INFO - Running main action method: create_virtualenv 07:37:32 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:32 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 07:37:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:32 INFO - Using real prefix '/tools/python27' 07:37:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:33 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:36 INFO - Installing pip.................done. 07:37:36 INFO - Return code: 0 07:37:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:37:36 INFO - Reading from file tmpfile_stdout 07:37:36 INFO - Output received: 07:37:36 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) 07:37:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84adbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c99d30>, '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 0x103b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c91b20>, '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.ULpxVTLECD/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.3Txqw2OpSi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 07:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:37:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ULpxVTLECD/Render', 07:37:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:36 INFO - 'HOME': '/Users/cltbld', 07:37:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:36 INFO - 'LOGNAME': 'cltbld', 07:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:36 INFO - 'MOZ_NO_REMOTE': '1', 07:37:36 INFO - 'NO_EM_RESTART': '1', 07:37:36 INFO - 'PAGER': '/bin/cat', 07:37:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:36 INFO - 'PWD': '/builds/slave/test', 07:37:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:36 INFO - 'SHELL': '/bin/bash', 07:37:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3Txqw2OpSi/Listeners', 07:37:36 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 07:37:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:36 INFO - 'USER': 'cltbld', 07:37:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:36 INFO - 'XPC_FLAGS': '0x0', 07:37:36 INFO - 'XPC_SERVICE_NAME': '0', 07:37:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:36 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 07:37:36 INFO - Cleaning up... 07:37:36 INFO - Return code: 0 07:37:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103e833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84adbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c99d30>, '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 0x103b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c91b20>, '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.ULpxVTLECD/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.3Txqw2OpSi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 07:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:37:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ULpxVTLECD/Render', 07:37:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:36 INFO - 'HOME': '/Users/cltbld', 07:37:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:36 INFO - 'LOGNAME': 'cltbld', 07:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:36 INFO - 'MOZ_NO_REMOTE': '1', 07:37:36 INFO - 'NO_EM_RESTART': '1', 07:37:36 INFO - 'PAGER': '/bin/cat', 07:37:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:36 INFO - 'PWD': '/builds/slave/test', 07:37:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:36 INFO - 'SHELL': '/bin/bash', 07:37:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3Txqw2OpSi/Listeners', 07:37:36 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 07:37:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:36 INFO - 'USER': 'cltbld', 07:37:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:36 INFO - 'XPC_FLAGS': '0x0', 07:37:36 INFO - 'XPC_SERVICE_NAME': '0', 07:37:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:36 INFO - Downloading/unpacking psutil>=3.1.1 07:37:36 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 07:37:36 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 07:37:36 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 07:37:36 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 07:37:36 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 07:37:36 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 07:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:37:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:40 INFO - Installing collected packages: psutil 07:37:40 INFO - Running setup.py install for psutil 07:37:40 INFO - building 'psutil._psutil_osx' extension 07:37:40 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 07:37:40 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 07:37:40 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 07:37:40 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 07:37:41 INFO - building 'psutil._psutil_posix' extension 07:37:41 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 07:37:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:37:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:37:41 INFO - ^ 07:37:41 INFO - 1 warning generated. 07:37:41 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 07:37:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:41 INFO - Successfully installed psutil 07:37:41 INFO - Cleaning up... 07:37:41 INFO - Return code: 0 07:37:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:37:41 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')]} 07:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:41 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')]} 07:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:41 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 0x103e833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84adbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c99d30>, '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 0x103b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c91b20>, '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.ULpxVTLECD/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.3Txqw2OpSi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 07:37:41 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 07:37:41 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 07:37:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ULpxVTLECD/Render', 07:37:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:41 INFO - 'HOME': '/Users/cltbld', 07:37:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:41 INFO - 'LOGNAME': 'cltbld', 07:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:41 INFO - 'MOZ_NO_REMOTE': '1', 07:37:41 INFO - 'NO_EM_RESTART': '1', 07:37:41 INFO - 'PAGER': '/bin/cat', 07:37:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:41 INFO - 'PWD': '/builds/slave/test', 07:37:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:41 INFO - 'SHELL': '/bin/bash', 07:37:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3Txqw2OpSi/Listeners', 07:37:41 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 07:37:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:41 INFO - 'USER': 'cltbld', 07:37:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:41 INFO - 'XPC_FLAGS': '0x0', 07:37:41 INFO - 'XPC_SERVICE_NAME': '0', 07:37:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:37:44 INFO - Installing collected packages: mozsystemmonitor 07:37:44 INFO - Running setup.py install for mozsystemmonitor 07:37:44 INFO - Successfully installed mozsystemmonitor 07:37:44 INFO - Cleaning up... 07:37:44 INFO - Return code: 0 07:37:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:44 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 0x103e833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84adbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c99d30>, '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 0x103b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c91b20>, '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.ULpxVTLECD/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.3Txqw2OpSi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 07:37:44 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 07:37:44 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 07:37:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ULpxVTLECD/Render', 07:37:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:44 INFO - 'HOME': '/Users/cltbld', 07:37:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:44 INFO - 'LOGNAME': 'cltbld', 07:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:44 INFO - 'MOZ_NO_REMOTE': '1', 07:37:44 INFO - 'NO_EM_RESTART': '1', 07:37:44 INFO - 'PAGER': '/bin/cat', 07:37:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:44 INFO - 'PWD': '/builds/slave/test', 07:37:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:44 INFO - 'SHELL': '/bin/bash', 07:37:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3Txqw2OpSi/Listeners', 07:37:44 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 07:37:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:44 INFO - 'USER': 'cltbld', 07:37:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:44 INFO - 'XPC_FLAGS': '0x0', 07:37:44 INFO - 'XPC_SERVICE_NAME': '0', 07:37:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:44 INFO - Downloading/unpacking jsonschema==2.5.1 07:37:44 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 07:37:44 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 07:37:44 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 07:37:44 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 07:37:44 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 07:37:44 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 07:37:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:37:47 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 07:37:47 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 07:37:47 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 07:37:47 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 07:37:47 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 07:37:47 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 07:37:47 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:47 INFO - warning: no files found matching '*.txt' 07:37:47 INFO - no previously-included directories found matching 'build' 07:37:47 INFO - no previously-included directories found matching 'dist' 07:37:47 INFO - no previously-included directories found matching '.git*' 07:37:47 INFO - Installing collected packages: jsonschema, functools32 07:37:48 INFO - Running setup.py install for functools32 07:37:48 INFO - warning: no files found matching '*.txt' 07:37:48 INFO - no previously-included directories found matching 'build' 07:37:48 INFO - no previously-included directories found matching 'dist' 07:37:48 INFO - no previously-included directories found matching '.git*' 07:37:48 INFO - Successfully installed jsonschema functools32 07:37:48 INFO - Cleaning up... 07:37:48 INFO - Return code: 0 07:37:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:37:48 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')]} 07:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:48 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')]} 07:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:48 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 0x103e833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84adbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c99d30>, '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 0x103b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c91b20>, '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.ULpxVTLECD/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.3Txqw2OpSi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 07:37:48 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 07:37:48 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 07:37:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ULpxVTLECD/Render', 07:37:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:48 INFO - 'HOME': '/Users/cltbld', 07:37:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:48 INFO - 'LOGNAME': 'cltbld', 07:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:48 INFO - 'MOZ_NO_REMOTE': '1', 07:37:48 INFO - 'NO_EM_RESTART': '1', 07:37:48 INFO - 'PAGER': '/bin/cat', 07:37:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:48 INFO - 'PWD': '/builds/slave/test', 07:37:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:48 INFO - 'SHELL': '/bin/bash', 07:37:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3Txqw2OpSi/Listeners', 07:37:48 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 07:37:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:48 INFO - 'USER': 'cltbld', 07:37:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:48 INFO - 'XPC_FLAGS': '0x0', 07:37:48 INFO - 'XPC_SERVICE_NAME': '0', 07:37:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:37:48 INFO - Cleaning up... 07:37:48 INFO - Return code: 0 07:37:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37:48 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')]} 07:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:48 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')]} 07:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:48 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 0x103e833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84adbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c99d30>, '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 0x103b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c91b20>, '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.ULpxVTLECD/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.3Txqw2OpSi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 07:37:48 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 07:37:48 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 07:37:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ULpxVTLECD/Render', 07:37:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:48 INFO - 'HOME': '/Users/cltbld', 07:37:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:48 INFO - 'LOGNAME': 'cltbld', 07:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:48 INFO - 'MOZ_NO_REMOTE': '1', 07:37:48 INFO - 'NO_EM_RESTART': '1', 07:37:48 INFO - 'PAGER': '/bin/cat', 07:37:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:48 INFO - 'PWD': '/builds/slave/test', 07:37:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:48 INFO - 'SHELL': '/bin/bash', 07:37:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3Txqw2OpSi/Listeners', 07:37:48 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 07:37:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:48 INFO - 'USER': 'cltbld', 07:37:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:48 INFO - 'XPC_FLAGS': '0x0', 07:37:48 INFO - 'XPC_SERVICE_NAME': '0', 07:37:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:48 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:48 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 07:37:48 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 07:37:48 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 07:37:48 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 07:37:48 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 07:37:48 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 07:37:51 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37:52 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 07:37:52 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 07:37:52 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 07:37:52 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 07:37:52 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 07:37:52 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 07:37:52 INFO - Downloading docopt-0.6.1.tar.gz 07:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:52 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:52 INFO - Running setup.py install for blobuploader 07:37:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:52 INFO - Running setup.py install for requests 07:37:53 INFO - Running setup.py install for docopt 07:37:53 INFO - Successfully installed blobuploader requests docopt 07:37:53 INFO - Cleaning up... 07:37:53 INFO - Return code: 0 07:37:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:53 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 0x103e833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84adbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c99d30>, '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 0x103b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c91b20>, '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.ULpxVTLECD/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.3Txqw2OpSi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 07:37:53 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 07:37:53 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 07:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ULpxVTLECD/Render', 07:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:53 INFO - 'HOME': '/Users/cltbld', 07:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:53 INFO - 'LOGNAME': 'cltbld', 07:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:53 INFO - 'MOZ_NO_REMOTE': '1', 07:37:53 INFO - 'NO_EM_RESTART': '1', 07:37:53 INFO - 'PAGER': '/bin/cat', 07:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:53 INFO - 'PWD': '/builds/slave/test', 07:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:53 INFO - 'SHELL': '/bin/bash', 07:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3Txqw2OpSi/Listeners', 07:37:53 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 07:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:53 INFO - 'USER': 'cltbld', 07:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:53 INFO - 'XPC_FLAGS': '0x0', 07:37:53 INFO - 'XPC_SERVICE_NAME': '0', 07:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:53 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-KiNP8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:53 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-_LyaNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:53 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-KqCmbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:54 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-om08AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:54 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-srRzCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:54 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-LQYNq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:54 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-EnOvA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:54 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-G8tCNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:54 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-jZBX0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:54 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-p_RKag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:54 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-jtg_L2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:54 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-NFeqO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:54 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-blpbq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:55 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-zajz1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:55 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-J4qnOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:55 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-cuf90i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:55 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-2mO5Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:55 INFO - Running setup.py install for manifestparser 07:37:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:55 INFO - Running setup.py install for mozcrash 07:37:55 INFO - Running setup.py install for mozdebug 07:37:55 INFO - Running setup.py install for mozdevice 07:37:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:56 INFO - Running setup.py install for mozfile 07:37:56 INFO - Running setup.py install for mozhttpd 07:37:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:56 INFO - Running setup.py install for mozinfo 07:37:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:56 INFO - Running setup.py install for mozInstall 07:37:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:56 INFO - Running setup.py install for mozleak 07:37:56 INFO - Running setup.py install for mozlog 07:37:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:56 INFO - Running setup.py install for moznetwork 07:37:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:57 INFO - Running setup.py install for mozprocess 07:37:57 INFO - Running setup.py install for mozprofile 07:37:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:57 INFO - Running setup.py install for mozrunner 07:37:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:57 INFO - Running setup.py install for mozscreenshot 07:37:57 INFO - Running setup.py install for moztest 07:37:57 INFO - Running setup.py install for mozversion 07:37:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:58 INFO - Cleaning up... 07:37:58 INFO - Return code: 0 07:37:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:58 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 0x103e833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84adbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c99d30>, '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 0x103b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c91b20>, '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.ULpxVTLECD/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.3Txqw2OpSi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 07:37:58 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 07:37:58 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 07:37:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ULpxVTLECD/Render', 07:37:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:58 INFO - 'HOME': '/Users/cltbld', 07:37:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:58 INFO - 'LOGNAME': 'cltbld', 07:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:58 INFO - 'MOZ_NO_REMOTE': '1', 07:37:58 INFO - 'NO_EM_RESTART': '1', 07:37:58 INFO - 'PAGER': '/bin/cat', 07:37:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:58 INFO - 'PWD': '/builds/slave/test', 07:37:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:58 INFO - 'SHELL': '/bin/bash', 07:37:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3Txqw2OpSi/Listeners', 07:37:58 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 07:37:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:58 INFO - 'USER': 'cltbld', 07:37:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:58 INFO - 'XPC_FLAGS': '0x0', 07:37:58 INFO - 'XPC_SERVICE_NAME': '0', 07:37:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:58 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-KlO6yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:58 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)) 07:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:58 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-4Kk0r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:58 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)) 07:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:58 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-KxxLzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:58 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)) 07:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:58 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-L04spq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:58 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-mrXp3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:58 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)) 07:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:58 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-EZVASF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:58 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)) 07:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:58 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-_Gy744-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:59 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)) 07:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:59 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-4mw_8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:59 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)) 07:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:59 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-T1G5Gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:59 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)) 07:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:59 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-8pvZpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:59 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)) 07:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:59 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-CDZBN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:59 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)) 07:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:59 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-NxTsrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:59 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)) 07:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:59 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-ptwS7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:59 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)) 07:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:59 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Ewm1Fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:59 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)) 07:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:59 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-k37DFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:59 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)) 07:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:59 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-5WErwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:00 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)) 07:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:00 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-D52nJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:00 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)) 07:38:00 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)) 07:38:00 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)) 07:38:00 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)) 07:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:00 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 07:38:00 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 07:38:00 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 07:38:00 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 07:38:00 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 07:38:00 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 07:38:02 INFO - Downloading blessings-1.6.tar.gz 07:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:02 INFO - Installing collected packages: blessings 07:38:02 INFO - Running setup.py install for blessings 07:38:02 INFO - Successfully installed blessings 07:38:02 INFO - Cleaning up... 07:38:03 INFO - Return code: 0 07:38:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:03 INFO - Reading from file tmpfile_stdout 07:38:03 INFO - Current package versions: 07:38:03 INFO - blessings == 1.6 07:38:03 INFO - blobuploader == 1.2.4 07:38:03 INFO - docopt == 0.6.1 07:38:03 INFO - functools32 == 3.2.3-2 07:38:03 INFO - jsonschema == 2.5.1 07:38:03 INFO - manifestparser == 1.1 07:38:03 INFO - mozInstall == 1.12 07:38:03 INFO - mozcrash == 1.0 07:38:03 INFO - mozdebug == 0.1 07:38:03 INFO - mozdevice == 0.48 07:38:03 INFO - mozfile == 1.2 07:38:03 INFO - mozhttpd == 0.7 07:38:03 INFO - mozinfo == 0.9 07:38:03 INFO - mozleak == 0.1 07:38:03 INFO - mozlog == 3.4 07:38:03 INFO - moznetwork == 0.27 07:38:03 INFO - mozprocess == 0.23 07:38:03 INFO - mozprofile == 0.28 07:38:03 INFO - mozrunner == 6.13 07:38:03 INFO - mozscreenshot == 0.1 07:38:03 INFO - mozsystemmonitor == 0.3 07:38:03 INFO - moztest == 0.7 07:38:03 INFO - mozversion == 1.4 07:38:03 INFO - psutil == 3.1.1 07:38:03 INFO - requests == 1.2.3 07:38:03 INFO - wsgiref == 0.1.2 07:38:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:04 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 0x103e833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84adbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c99d30>, '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 0x103b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c91b20>, '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.ULpxVTLECD/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.3Txqw2OpSi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 07:38:04 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 07:38:04 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 07:38:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ULpxVTLECD/Render', 07:38:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:04 INFO - 'HOME': '/Users/cltbld', 07:38:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:04 INFO - 'LOGNAME': 'cltbld', 07:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:04 INFO - 'MOZ_NO_REMOTE': '1', 07:38:04 INFO - 'NO_EM_RESTART': '1', 07:38:04 INFO - 'PAGER': '/bin/cat', 07:38:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:04 INFO - 'PWD': '/builds/slave/test', 07:38:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:04 INFO - 'SHELL': '/bin/bash', 07:38:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3Txqw2OpSi/Listeners', 07:38:04 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 07:38:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:04 INFO - 'USER': 'cltbld', 07:38:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:04 INFO - 'XPC_FLAGS': '0x0', 07:38:04 INFO - 'XPC_SERVICE_NAME': '0', 07:38:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:04 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)) 07:38:04 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)) 07:38:04 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)) 07:38:04 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)) 07:38:04 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)) 07:38:04 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)) 07:38:04 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)) 07:38:04 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)) 07:38:04 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)) 07:38:04 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)) 07:38:04 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)) 07:38:04 INFO - Cleaning up... 07:38:04 INFO - Return code: 0 07:38:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103df9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe84adbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c99d30>, '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 0x103b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c91b20>, '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.ULpxVTLECD/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.3Txqw2OpSi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 07:38: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', 'jsonschema'] in /builds/slave/test/build 07:38: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 jsonschema 07:38:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ULpxVTLECD/Render', 07:38:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:04 INFO - 'HOME': '/Users/cltbld', 07:38:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:04 INFO - 'LOGNAME': 'cltbld', 07:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:04 INFO - 'MOZ_NO_REMOTE': '1', 07:38:04 INFO - 'NO_EM_RESTART': '1', 07:38:04 INFO - 'PAGER': '/bin/cat', 07:38:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:04 INFO - 'PWD': '/builds/slave/test', 07:38:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:04 INFO - 'SHELL': '/bin/bash', 07:38:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3Txqw2OpSi/Listeners', 07:38:04 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 07:38:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:04 INFO - 'USER': 'cltbld', 07:38:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:04 INFO - 'XPC_FLAGS': '0x0', 07:38:04 INFO - 'XPC_SERVICE_NAME': '0', 07:38:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:38:05 INFO - Cleaning up... 07:38:05 INFO - Return code: 0 07:38:05 INFO - Running post-action listener: _resource_record_post_action 07:38:05 INFO - Running post-action listener: _start_resource_monitoring 07:38:05 INFO - Starting resource monitoring. 07:38:05 INFO - [mozharness: 2016-11-17 15:38:05.059339Z] Finished create-virtualenv step (success) 07:38:05 INFO - [mozharness: 2016-11-17 15:38:05.060333Z] Running install step. 07:38:05 INFO - Running pre-action listener: _resource_record_pre_action 07:38:05 INFO - Running main action method: install 07:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:05 INFO - Reading from file tmpfile_stdout 07:38:05 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:05 INFO - Reading from file tmpfile_stdout 07:38:05 INFO - Output received: 07:38:05 INFO - Usage: mozinstall [options] installer 07:38:05 INFO - Options: 07:38:05 INFO - -h, --help show this help message and exit 07:38:05 INFO - -d DEST, --destination=DEST 07:38:05 INFO - Directory to install application into. [default: 07:38:05 INFO - "/builds/slave/test"] 07:38:05 INFO - --app=APP Application being installed. [default: firefox] 07:38:05 INFO - mkdir: /builds/slave/test/build/application 07:38:05 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'] 07:38:05 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 07:38:38 INFO - Reading from file tmpfile_stdout 07:38:38 INFO - Output received: 07:38:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:38:38 INFO - Running post-action listener: _resource_record_post_action 07:38:38 INFO - [mozharness: 2016-11-17 15:38:38.970557Z] Finished install step (success) 07:38:38 INFO - [mozharness: 2016-11-17 15:38:38.970699Z] Running run-tests step. 07:38:38 INFO - Running pre-action listener: _resource_record_pre_action 07:38:38 INFO - Running main action method: run_tests 07:38:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:38:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:38:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:38:38 INFO - 2016-11-17 07:38:38.985 screenresolution[1626:7432] starting screenresolution argv=screenresolution get 07:38:38 INFO - 2016-11-17 07:38:38.987 screenresolution[1626:7432] Display 0: 1600x1200x32@60 07:38:38 INFO - 2016-11-17 07:38:38.993 screenresolution[1627:7434] starting screenresolution argv=screenresolution list 07:38:38 INFO - Available Modes on Display 0 07:38:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:38:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:38:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:38:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:38:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:38:39 INFO - Intel Iris: 07:38:39 INFO - Chipset Model: Intel Iris 07:38:39 INFO - Type: GPU 07:38:39 INFO - Bus: Built-In 07:38:39 INFO - VRAM (Dynamic, Max): 1536 MB 07:38:39 INFO - Vendor: Intel (0x8086) 07:38:39 INFO - Device ID: 0x0a2e 07:38:39 INFO - Revision ID: 0x0009 07:38:39 INFO - Displays: 07:38:39 INFO - Display: 07:38:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:38:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:38:39 INFO - Display Serial Number: 1600x1200 60 07:38:39 INFO - Main Display: Yes 07:38:39 INFO - Mirror: Off 07:38:39 INFO - Online: Yes 07:38:39 INFO - Rotation: Supported 07:38:39 INFO - Return code: 0 07:38:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:39 INFO - Python 2.7.3 07:38:39 INFO - Return code: 0 07:38:39 INFO - grabbing minidump binary from tooltool 07:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:39 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 0x103c99d30>, '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 0x103b00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c91b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:39 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 07:38:39 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 07:38:39 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 07:38:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:39 INFO - Return code: 0 07:38:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:38:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:38:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:38:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ULpxVTLECD/Render', 07:38:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:39 INFO - 'HOME': '/Users/cltbld', 07:38:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:39 INFO - 'LOGNAME': 'cltbld', 07:38:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:39 INFO - 'MOZ_NO_REMOTE': '1', 07:38:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:39 INFO - 'NO_EM_RESTART': '1', 07:38:39 INFO - 'PAGER': '/bin/cat', 07:38:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:39 INFO - 'PWD': '/builds/slave/test', 07:38:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:39 INFO - 'SHELL': '/bin/bash', 07:38:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3Txqw2OpSi/Listeners', 07:38:39 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 07:38:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:39 INFO - 'USER': 'cltbld', 07:38:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:39 INFO - 'XPC_FLAGS': '0x0', 07:38:39 INFO - 'XPC_SERVICE_NAME': '0', 07:38:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:38:39 INFO - mozversion application_buildid: 20161117053428 07:38:39 INFO - mozversion application_changeset: 0005d0bfadf72746ce36f4e8d09d9504b814557e 07:38:39 INFO - mozversion application_display_name: Nightly 07:38:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:39 INFO - mozversion application_name: Firefox 07:38:39 INFO - mozversion application_remotingname: firefox 07:38:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:38:39 INFO - mozversion application_vendor: Mozilla 07:38:39 INFO - mozversion application_version: 53.0a1 07:38:39 INFO - mozversion platform_buildid: 20161117053428 07:38:39 INFO - mozversion platform_changeset: 0005d0bfadf72746ce36f4e8d09d9504b814557e 07:38:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:38:39 INFO - mozversion platform_version: 53.0a1 07:38:39 INFO - using testdate: 1479397119 07:38:39 INFO - actual date: 1479397119 07:38:39 INFO - starting webserver on 'localhost:49252' 07:38:39 INFO - SUITE-START | Running 2 tests 07:38:39 INFO - TEST-START | dromaeo_css 07:38:39 INFO - operating with platform_type : mac_ 07:38:39 INFO - Initialising browser for dromaeo_css test... 07:38:39 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpH6YFJc/profile http://localhost:49252/getInfo.html) 07:38:42 INFO - PROCESS | 1637 | 2016-11-17 07:38:42.666 plugin-container[1640:7610] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 07:38:42 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:38:42 INFO - PROCESS | 1637 | 2016-11-17 07:38:42.668 plugin-container[1640:7610] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 07:38:42 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:38:42 INFO - PROCESS | 1637 | 2016-11-17 07:38:42.668 plugin-container[1640:7610] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:38:42 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 07:38:42 INFO - PROCESS | 1637 | colorDepth:24 07:38:42 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 07:38:42 INFO - PROCESS | 1637 | __metrics 07:38:42 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 07:38:43 INFO - TEST-INFO | 1637: exit 0 07:38:43 INFO - Browser initialized. 07:38:43 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:43 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpH6YFJc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:45 INFO - PROCESS | 1641 | 2016-11-17 07:38:45.966 plugin-container[1642:7729] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 07:38:45 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:38:45 INFO - PROCESS | 1641 | 2016-11-17 07:38:45.966 plugin-container[1642:7729] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 07:38:45 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:38:45 INFO - PROCESS | 1641 | 2016-11-17 07:38:45.966 plugin-container[1642:7729] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:38:55 INFO - PROCESS | 1641 | RSS: Main: 237920256 07:38:55 INFO - PROCESS | 1641 | 07:39:45 INFO - PROCESS | 1641 | 1479397185359 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] 07:41:58 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49252/tests/dromaeo/cssquery-ext.html) 07:42:00 INFO - PROCESS | 1641 | RSS: Main: 251592704 07:42:00 INFO - PROCESS | 1641 | 07:45:02 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-ext.html (next: http://localhost:49252/tests/dromaeo/cssquery-jquery.html) 07:45:03 INFO - PROCESS | 1641 | RSS: Main: 261480448 07:45:03 INFO - PROCESS | 1641 | 07:48:05 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49252/tests/dromaeo/cssquery-mootools.html) 07:48:06 INFO - PROCESS | 1641 | RSS: Main: 265822208 07:48:06 INFO - PROCESS | 1641 | 07:51:07 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49252/tests/dromaeo/cssquery-prototype.html) 07:51:08 INFO - PROCESS | 1641 | RSS: Main: 264683520 07:51:08 INFO - PROCESS | 1641 | 07:54:11 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49252/tests/dromaeo/cssquery-yui.html) 07:54:12 INFO - PROCESS | 1641 | RSS: Main: 269832192 07:54:12 INFO - PROCESS | 1641 | 07:57:15 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-yui.html (next: http://localhost:49252/tests/dromaeo/cssquery-dojo.html) 07:57:15 INFO - PROCESS | 1641 | RSS: Main: 271974400 07:57:15 INFO - PROCESS | 1641 | 07:57:15 INFO - PROCESS | 1641 | __start_tp_report 07:57:15 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 07:57:15 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 07:57:15 INFO - PROCESS | 1641 | |i|pagename|runs| 07:57:15 INFO - PROCESS | 1641 | |0;dojo.html;2830.900918467854;3158.0999415166684;3211.2293049668087;3299.8020118792865;3387.1532116970757;5360.705161216131;5645.661260324373;5713.942860571398;5747.224124743158;5827.329857066438;5683.772649094041;5734.082546792514;5755.366909639947;5833.912491312633;5903.409659034094;5164.50937160971;5178.40448348441;5214.217867319894;5290.7354632268425;5371.435999220084;5344.518993290603;5349.491798279158;5364;5379.515843574078;5419.512243898049;5156.664816786934;5289.233061206142;5293.814716484904;5304.734763261841;5305.840824775243;5194.896102077937;5249.947500524984;5297.046531624306;5300.628955973083;5315.255864179018;5181.35233095863;5193.63644544882;5210.557102646279;5235.005348983719;5255.106631872591;5656;5723.656580605136;5735.996200664908;5808.8838223235725;5886.793962211302;5485.424030476783;5932.584719069667;6104.610739188311;6131.3868613138775;6132.294786099611;6194;6195.969020154916;6200;6200.100985357143;6213.5339849511465;5792.855178620568;5950.702464876739;5961.701914904281;5968.7015649217365;5989.520838332923;6124.075808605272;6139.10982907476;6177.227846519185;6187.969060154761;6207.875842483125;6111.561351782648;6127.80043271483;6136.325004249529;6170.969145154246;6194.225721784777;5202.505761952609;6101.328853826076;6178.66017369049;6187.783427580103;6193.597416167935;4764.690295130806;5866.002779527491;6124.411449639965;6136.079588061737;6138.878900475427;6089.391060893875;6095.969520152371;6128.5359331975715;6137.84655383619;6162.691865406801;3932.6067393260446;4963.230699241623;4986.301917731521;4989.875253118628;4994.90010199794;4415.867523974286;4431.357453169337;4460.799264033127;4461.776911154429;4474.127545128668;5877.941220587825;5920.2895652521975;5948.821535353946;5991.3409524953095;6005.669688167105;6162.630242185483;6175.011998080286;6196.938030619726;6197.81406557795;6201.782937597162;5974.163617093611;6027.367126451747;6036.0644100164545;6053.576249662481;6066.332703402622;5349.063913815145;5405.297311349499;5418.647787893774;5470.753816078286;5475;5340.412554618911;6211.13044173807;6237.345078766664;6247.156633854372;6262.342454042351;6129.877402452015;6143.815685529441;6155.446009859134;6159.19930409044;6159.538034647329;6263.906041409291;6319.399657032574;6342.968285158545;6355.491560675227;6356.078368636429;6042.425969532887;6115.021596544531;6120.995732433061;6123.357047509948;6130.049842274455;6133.570650054453;6150.938490615036;6156.907646385218;6174.722137503733;6174.845628859314;5993.31076926159;6008.24896887889;6069.787557435468;6131.509479241739;6138.693065346804;6115.209918062534;6131.743695906945;6132.845047373448;6139.508839292756;6158.876822463615;5180.870478238075;5752.884942301214;5984.251968503937;6052.334243233329;6079.939200608114;6004.459598636144;6066.575339726353;6094.055421409511;6103.389661034039;6167.969160154171;6005.6396616203165;6007.729652165751;6015.518758499397;6026.909596356146;6027.728752206073 07:57:15 INFO - PROCESS | 1641 | |1;ext.html;471.24130150457756;480.0950208856305;483.9346688197093;500.09982032341776;511.7390131033172;28745.56881646777;32539.349213015725;32721.99999999997;34073;34182.48726269108;32509;32816.34367312658;32874.34251314972;32894.01317960459;32998.50502242468;7194.676239569232;7359.227281135484;7365.705371785122;7372.483926125174;7386.4460165487535;7517.285857843523;7596.278353556431;7601.429892758038;7605.467617266793;7610.972518709958;6036.577439579231;6703.1956165260235;7260.564366138048;7630.809229769273;7646.885296720554;7578.090629124513;7605.657745401415;7610.429217808659;7618.123915749649;7642.3121919027;7554.320111189964;7569.583672897988;7665.156832748393;7669.348105411047;7688.500247483896;30688.693113069032;30774.38451230985;30926.381472370427;31046.84476577625;31092.222694432596;3329.234276116507;3340.5657264555452;3345.3643807676463;3403.3193361327835;3467.6705712957228;20723;20873.89563052175;21026.47433814167;21429.67855482169;21508.247211347527;2430.6718592989896;2738.86305684715;2811.1004478566865;2851.9429611407654;2855;468911;474426;475509;476140;477822;55390.72304638451;55515.444845551836;55604.72197639067;55751.721241393534;55786.72106639522;55663.165052524244;56848.147277790864;57397.42602573921;57666.55833604193;57758.422415775305;15282.465113720966;15466.5360039199;15487.457938972082;15498.767518487231;15505.534833954775;12128.090393220544;12162.756744865053;12196.39018049094;12211.877881221251;12234.938825305995;14500;14836.777448338284;14901.254937253094;15007.849921500645;15177;5585.413531579207;5703.9429605704245;6584.703688333941;6677.699503522256;6692.364225398676;851.6678495386805;891.6388862510694;936.9672061477816;961.8172547216006;1037.7820657661825;28496.28759280993;28995.275118121794;29191.56212656812;29420.411591768472;29833.552496712568;942.1144124522926;1025.8307379282335;1095.4358505369742;1131.3607811586428;1217.452146534063;14169.504067357593;14470.421183152766;14663.853361466248;14776.92611536957;14942;638320;642698;643805;644088;644998;49587.752061240186;49994.75002624963;50181;50240.7247239042;50247.24134655269;1332.2739107186605;1346.9326533673277;1374.4296117111287;1375.0924389902616;1381.8687224713635;23705.881470592536;27320.590191147545;28613.28466788347;29070.7092929068;29129.56305655459;46097.308540371254;46299.3055104167;46320;46336.304955425025;46385;579580;583470;583472;583898;584905;34466.483002754474;34613.96158115261;35000.29999399947;35173.53785235009;35260.647393526764;40653.983650408976;40699;41462.79268603637;41694.95762605959;41815.37276940788;30064.549031764105;34414;34415.65584344225;35554.46668300029;35737.1065723359;29044.56433153547;30515.542266866458;33829.66170338265;34382;34815.47776783401;34376.312473750884;34414.82792586021;34745.65254347424;34960.9511714649;35106.64893351136;24999;28442.146735597966;29026;31283;31449.685503144676;23400.414989625395;23656.172033978728;23721.762782371956;23940.40148996289;24343 07:57:15 INFO - PROCESS | 1641 | |2;jquery.html;316.42884593309077;373.92708421857714;374.5280946008029;385.82059342405773;403.4976454314379;13975.091619044755;15255.389784408624;15371.461998830044;15792.44726434575;16205.83794162058;16077.758833617505;16312.102834344107;16379.59051023725;16507.422240221596;17777.555561110978;4894.412670479539;5197.662151960129;5248.107821670325;5252.8686782830355;5256.316678831747;2928.487514684932;3704.407294832827;4844.5155484451625;5096.79612815487;5124.256982737501;5133.614978876581;5149.459306772791;5155.355580552431;5163.896722065557;5187.1181899077055;4948.604111671076;5075.6447048706605;5126.179811230222;5132.435432102466;5141.871453213681;4472.1502914446155;4532.116237333721;4537.591616754475;4546.590806827401;4560.019595786888;20802.47993800152;21006.159753609838;21148.259810906544;21252.14991400342;21396.358109256747;1992.9736185864292;2065.7624373197123;2145.03473436954;2147.2377306056437;2387.307680772574;12533.623991280276;13208.537701180412;13375.665608359772;13443.462261509529;14029.017968742191;1629.413411171977;1648.0606054548912;1679.9748003779953;1689.9746503802453;1776.253973331204;120276;122922.54220456802;125112;125904;127349.36325318407;9185.943616484055;9495.24038076966;10196.286259961731;10654.643787207006;10805.081568066802;13390.26353550564;13461.461541538425;13467.865321346857;13470.730585388434;13507.662308442368;8000.271097168886;8302.958485207535;8359;8378.790530236793;8404.537750423664;8303.916960830315;8316.126806685332;8322.042965058974;8470.025947016173;8503.277221436247;5368.8657783554945;6336.303006669263;6359.523035772243;6368.745250189941;6390.392912673288;1461.9122852628877;1638.270969418621;1800.9729854051939;1803.9007854567863;1846.4460661801675;810.2869474862084;895.789489469974;923.6028507741736;950.3585080071063;960.500539719342;20930.790692092884;21675.34973950784;21693.34919952404;21777.78222217789;21857.562848743255;869.443556124081;940.191435365585;955.7992821507422;976.4531862157214;980.7891303369667;11062.834057489144;11380.317180969168;11409;11546.826797598043;11576.942115289537;578323;592653;593287;598928;603784;93562.53218733863;114192;114407;119100.8089919107;123296;1018.994905025485;1019.8215312320315;1022.223110436074;1043.3896170740202;1062.1396668698378;16269.51191464258;17053.57366065858;18990.24039038478;19412.417627471197;19475.2163416159;49407.50592494173;52848.73575632097;53201.4679853212;53404;53461;72820.9076863858;73125.90311145231;73175;73598.63200683962;74275.62862185655;7420.814479638052;7605.125410577854;7710.267524585155;7804.6878124874365;7813.1405545388825;12274.570390036306;12476.625701228977;12478.313692746622;12674.873251267369;12727.23636581808;9325.580348884452;10045.648402305884;10199.84700229512;10674.039336459446;10790.67627971162;10264.692059238234;10475.738106547396;10483.68548943533;10876.293040952312;10913.727156821144;10459.372437653765;10908.34549927007;10976.945115274373;10980.066694331072;11164.9951504365;7709.306162445407;7818.17909119557;7861.803454913673;7887.763367098996;8066.475679080841;7915.287624113857;10535.631252906418;10547.208959328234;10774.46127693628;10835.729106772395 07:57:15 INFO - PROCESS | 1641 | |3;mootools.html;1493.3280023989207;1517.5902506323293;1550.875929925606;1683.8970474339305;1731.3940120957675;7229.7831065068;7456.440766942487;7711.113221979467;8146.103928567868;8164.306033987111;7508.81227969301;7737.381009519239;7758.806029849256;7821.843563128748;7851.528908265494;1692.6360832420996;2042.3974927396453;2044.4684382060623;2049.7847725988704;2053.035073515445;1880.8213219744102;1982.9093998300948;2072.9585408291823;2086.394945465813;2102.6740855167473;2067.627826991141;2067.782882797307;2077.1276064053136;2077.366403247009;2107.924958271285;2078.1064142418754;2101.821345185661;2106.810387065164;2107.093949601671;2112.7570329412006;2093.079045220098;2111.609352269835;2114.904829282686;2117.74587049555;2127.659574468093;7791.961040194819;7870.921290787133;7882.881756773653;7894;7944.960275198645;5097.9490205097845;5229.424763276036;5249.973750131263;5255.789768409259;5277.736113194325;3352.7485438591957;3441.724662027057;3525.6298088700573;3588.9641103588892;3609.2420591675777;955.4219697083234;991.3308516751237;1025.5897640943608;1031.3760175094035;1031.829748091564;10978.451077446096;11115.11079113677;11117.444127793578;11137.665870023913;11146.498407571678;3623;4627.329037289574;4633.374494443275;4719.882002949954;4806.855794326176;8855.601497932608;8867.689630863018;8871.733847984571;8914.509701966454;8936.687215947411;5116.948830511647;5147.510986456281;5163.948360516422;5180.067587834226;5180.870478238075;4113.4858142732155;4775.044991001813;4797.712137271775;4840.128776820206;4867.075255701406;3633.9818300908855;3658.9451158232646;3704.722145839019;3743.9142648632137;3746.0260332313796;1148.2019996102795;1151.585429245471;1155.96532104037;1160.5995931403652;1161.7560312334335;691.7440546997643;803.6263137640908;822.3667775812711;832.9130484717381;873.868919662043;5186.766595503212;5491.807786727445;5497.725113744297;5669.6314739541795;5723;885.1016218538189;885.1104639836923;891.7592250092439;932.6083045121065;942.2603256443659;3631.927361452809;3688.686461650736;3731.7574357666663;3807.8857634271017;3840.347140986039;9582.425054496753;10265.794684106277;10331.845022324671;10351.171906247482;10359.015893490106;8990.921089469175;9759.609615615296;10147;10327.32872363294;10332.328398654214;6831.555948863407;7777.338926191337;7981.920180798234;7991.800204994805;7993.600319983978;5460.34475862899;5491.917621235605;5580.135079062752;5613.214150019082;5675.602707810413;9603.519824008912;9771.316007879665;9796.314258001872;9838.262130340396;9871.358361706467;9597.568109434953;9807.06832850878;9841.557129929028;9950.701478955643;9966.604675345603;6304.243490781136;6484.643344615903;6681.632510211985;6770.086038384952;6883.724651013903;7973.481723687942;7993.600319984093;8201.384896132695;8203.179682031749;8247.381446391424;5679.716014199191;7166.390856777232;7342.192358840416;7385.187629360874;7416.66625001887;7022.859542809218;7114.324139206767;7212.134543854771;7236.782896513113;7269.818254543678;6709.36261055199;6740.6966686498245;6796.320367963164;6797.150356205474;6857.348551887562;4838.975805120952;4885.2427873679635;4889.657723959289;4906.55840974314;4945.505449455026;4224.218519573888;4548.703619468568;4605.884852878705;4691.859244222679;4882.169186555042 07:57:15 INFO - PROCESS | 1641 | |4;prototype.html;274.56481476859165;302.14342339467606;305.5920346337639;309.3364732648469;312.8560862003478;4500.729956202626;4590.770461476921;5409.889313644655;5439.782408703652;5451.427600101992;5350.678959262447;5516.951779161956;5542.5565954723625;5562.3047119110115;5562.3047119110115;3388;3894.1822217334393;3960.940585891207;4283.229018776619;4294.656427485794;3798.65812076913;3859.36320507116;4158.087279851272;4290.76400797956;4314.956850431503;3591.7844929304197;3959.2477429288488;4101.826032202922;4147.232761939051;4147.813348399314;4102.815373308208;4116.403121547389;4122.0107174277955;4142.2543942090415;4165.45849039626;3173.2701478660038;3293.7859039162377;3341.1313058604937;3581.606023337431;3599.236374176661;4752.049590081998;5016.871203979112;5025.7235852028125;5429.864253393657;5435.1520483035565;3750.5124333836698;4187.748735075875;4617.72293662378;4812.614990800727;4826.638002149853;5421.918671219935;5825.271841019872;5883.470487656089;5906.700525884342;5939.346671866091;3421.298633780094;3841.058940559553;3898.083950271684;3904.7657140571655;3929.941050884239;5393.4336894626285;5616.466435688603;5912.497437717756;5977.073553599155;6057.9398605243905;3533.911652208715;3705.333040052816;3906;3939.6651284641125;3982.601739825994;3508.298475239507;4028.099768166915;4066.698656429914;4092.9795351023054;4095.0990782027907;4044;4629.699069560468;4805.423349198119;4814.352106341568;4834.854954351375;5467.753951072212;5650.802221922213;5883.382244864228;5971.641701497924;6031.396860313934;1261.5332327039055;1276.074845736852;1292.4894666606638;1306.405585458614;1316.4799904038043;854.0775961961067;882.5234373438271;883.2933653077512;885.1723638398119;891.4116682989196;4562.657800664963;4854.975725121351;4953.6037117030555;5130.820421285312;5196.714180720097;5171.50870667286;5707.429257074343;5766.86748793574;5770.153550863767;5792.102224155178;4606.953930460652;4681.040386720714;4990.4011518618;5204.769206946994;5273.630845840831;2749.7250274972344;2793.52510073288;2796.944061118766;2909.461749576335;2936.456755500239;4776.976115119472;5343.973280133652;5843.766249350064;5864.120381942743;6037.818865434044;5381.865453363619;5554.638948468337;5816.360200377955;5844.357120716718;5962.612430192024;5465.836024919259;5821.767129314865;5898.528117750569;5905.52755779528;5929.762809487572;5379.327584051994;5631.6902570359025;5662.697579556642;5671.355306960935;5698.8290351289525;4649.465311489087;5179.611529135405;5345.412004679404;5592.692401917933;5598.836657288619;5287.524122828964;5405.432429594836;5768.7404066817935;5953.970230148821;5955.937453164948;3614.6385361463645;3709.8145092744717;3744.382176940774;3785.4700341951598;3800.3159431301524;5184.351956005499;5285.418603953485;5551.805686800943;5628.015097358028;5643.858903527444;4805.399325084364;5567.693776842312;5606.6636001840025;5806.603137164806;6067.876243314981;4804.4357860032405;5187.766550505161;5611.915821262766;5822.942954948686;5833.941660583339;5084.923726144185;5238.869028274324;5408.621396502364;5500.532454741392;5636.083731531299;4529.252673308867;4794.7842347093765;4896.041583366682;5350.170723537858;5492.890142197213;4717.69334993238;4768.854015692883;5164.845054648366;5676.375598684224;5711.257536520226 07:57:15 INFO - PROCESS | 1641 | |5;yui.html;625.2996643758988;696.2376198063121;696.8257935516122;742.8737114690502;786.9999999999998;13097.214167149967;13783.379747911344;13791.172529648227;13825.58523244303;13829.515966941146;12418.254904705702;12470.064745144127;12525.749485010294;12528.49886004561;12569.434375453104;635.0632816595531;653.7581094994835;783.3615603283334;794.7973266816954;811.6834434570522;708.3270892651975;815.1888870573788;815.2744057788573;820.9507429554216;826.6197549127409;855.1363123245536;861.9870701939476;863.5639002303827;865.4547634989948;866.9826603467958;857.7126662568047;858.3819649852096;858.9226969572737;859.9011113721876;861.9699459146354;630.5460068750538;639.5842702243532;639.808057582728;640.2445114764575;642.0048924167568;11853;11947.462364193632;12153.210041347284;12332.19840710351;12343.629691109281;10756.569737210502;10762.623308184176;10847.837282440769;10860.402677852715;11088.722781930435;9395.154436100784;9521.57152928113;9577.329586928918;9587.472689002103;9821.116099551075;3059.5410688396696;3081.7072378124044;3135.513995330705;3157.431662300785;3160.541721450377;92922;97726;99059.0188196232;100756.99999999927;101496;8275.08974012858;8320.251177394064;8362.12197719243;8503.914960850436;8597.18326758957;16061.839381606269;16793.832061679226;17893.552661183316;18177.363792267206;18211.72682409765;7593.088829340514;7644.732434364771;7681.807954801175;7738.574378409242;7838.725644602411;4180;4202.621764041251;4328.783560821947;4401.823927042882;4474.463064432289;3222.113918672384;3255.251292202807;3316.8009919404913;3335.6497567755523;3340.7160391367006;637.1048676609371;640.5324113397246;644.8484606117559;647.3429469088878;657.1850904877917;539.3931826694968;616.6485103490967;640.7052755732323;659.3867703036223;666.620026584842;8307.050463110842;8311.33509319253;8453.154684531497;8833.381663283508;8962.596683149273;603.6287683074966;622.5735371270604;625.6621424430847;641.3330136657823;658.9637569933603;3799.772013679188;3941.034446560611;4398.978005109954;4407.382966384709;4471.463424389029;75232.4953500927;90742;110382.79234415427;111888;116007;79705.60147199227;91258;102975.48512257541;106032.46983765032;107974.46012769885;83794.58102709448;85759.57120214484;92662.53668731613;93302.53348733348;95196;8024.919750802417;8523.957380213307;8664.82670346577;8686.82626347482;8791.34064945119;42721.35917961171;51335.486645134566;52306.16928407487;55097.04126628623;56064.71967640136;73380.26619733735;75455.86816197651;75892.62053689697;76837.46325073355;77133.61433192798;10449.05958463742;10466.424346661006;11092.389918554234;11206.38364889939;11304.886951130384;11766.82349764737;12090.455929483018;12171;12374;12834.358282085672;10090.646132778831;11413.029892458902;11420.600278990196;11554.480048397674;12080.818787718366;11229.831552526883;11404.714882128013;11655.708607284885;11830.585929492427;11966.64100076999;11171.385573793194;11460.885391145981;11638.301701897914;11733.178677492835;11942.402879856147;9369.81260374775;9538.475383853676;9654.27592930519;9745.610175592898;10038.196944244297;6574.704138313692;8972.506512141896;9854.605815767289;9872.40765554069;9896.158826499828 07:57:15 INFO - PROCESS | 1641 | __end_tp_report 07:57:15 INFO - PROCESS | 1641 | __start_cc_report 07:57:15 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,387 07:57:15 INFO - PROCESS | 1641 | __end_cc_report 07:57:15 INFO - PROCESS | 1641 | __startTimestamp1479398235299__endTimestamp 07:57:15 INFO - PROCESS | 1641 | 07:57:15 INFO - PROCESS | 1641 | ------- Summary: start ------- 07:57:15 INFO - PROCESS | 1641 | Number of tests: 6 07:57:15 INFO - PROCESS | 1641 | 07:57:15 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5721.00 Median:6005.67 stddev:652.24 (10.9%) stddev-sans-first:613.57 07:57:15 INFO - PROCESS | 1641 | Values: 2830.9 3158.1 3211.2 3299.8 3387.2 5360.7 5645.7 5713.9 5747.2 5827.3 5683.8 5734.1 5755.4 5833.9 5903.4 5164.5 5178.4 5214.2 5290.7 5371.4 5344.5 5349.5 5364.0 5379.5 5419.5 5156.7 5289.2 5293.8 5304.7 5305.8 5194.9 5249.9 5297.0 5300.6 5315.3 5181.4 5193.6 5210.6 5235.0 5255.1 5656.0 5723.7 5736.0 5808.9 5886.8 5485.4 5932.6 6104.6 6131.4 6132.3 6194.0 6196.0 6200.0 6200.1 6213.5 5792.9 5950.7 5961.7 5968.7 5989.5 6124.1 6139.1 6177.2 6188.0 6207.9 6111.6 6127.8 6136.3 6171.0 6194.2 5202.5 6101.3 6178.7 6187.8 6193.6 4764.7 5866.0 6124.4 6136.1 6138.9 6089.4 6096.0 6128.5 6137.8 6162.7 3932.6 4963.2 4986.3 4989.9 4994.9 4415.9 4431.4 4460.8 4461.8 4474.1 5877.9 5920.3 5948.8 5991.3 6005.7 6162.6 6175.0 6196.9 6197.8 6201.8 5974.2 6027.4 6036.1 6053.6 6066.3 5349.1 5405.3 5418.6 5470.8 5475.0 5340.4 6211.1 6237.3 6247.2 6262.3 6129.9 6143.8 6155.4 6159.2 6159.5 6263.9 6319.4 6343.0 6355.5 6356.1 6042.4 6115.0 6121.0 6123.4 6130.0 6133.6 6150.9 6156.9 6174.7 6174.8 5993.3 6008.2 6069.8 6131.5 6138.7 6115.2 6131.7 6132.8 6139.5 6158.9 5180.9 5752.9 5984.3 6052.3 6079.9 6004.5 6066.6 6094.1 6103.4 6168.0 6005.6 6007.7 6015.5 6026.9 6027.7 07:57:15 INFO - PROCESS | 1641 | 07:57:15 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:67342.74 Median:19106.66 stddev:153194.81 (801.8%) stddev-sans-first:153542.29 07:57:15 INFO - PROCESS | 1641 | Values: 471.2 480.1 483.9 500.1 511.7 28745.6 32539.3 32722.0 34073.0 34182.5 32509.0 32816.3 32874.3 32894.0 32998.5 7194.7 7359.2 7365.7 7372.5 7386.4 7517.3 7596.3 7601.4 7605.5 7611.0 6036.6 6703.2 7260.6 7630.8 7646.9 7578.1 7605.7 7610.4 7618.1 7642.3 7554.3 7569.6 7665.2 7669.3 7688.5 30688.7 30774.4 30926.4 31046.8 31092.2 3329.2 3340.6 3345.4 3403.3 3467.7 20723.0 20873.9 21026.5 21429.7 21508.2 2430.7 2738.9 2811.1 2851.9 2855.0 468911.0 474426.0 475509.0 476140.0 477822.0 55390.7 55515.4 55604.7 55751.7 55786.7 55663.2 56848.1 57397.4 57666.6 57758.4 15282.5 15466.5 15487.5 15498.8 15505.5 12128.1 12162.8 12196.4 12211.9 12234.9 14500.0 14836.8 14901.3 15007.8 15177.0 5585.4 5703.9 6584.7 6677.7 6692.4 851.7 891.6 937.0 961.8 1037.8 28496.3 28995.3 29191.6 29420.4 29833.6 942.1 1025.8 1095.4 1131.4 1217.5 14169.5 14470.4 14663.9 14776.9 14942.0 638320.0 642698.0 643805.0 644088.0 644998.0 49587.8 49994.8 50181.0 50240.7 50247.2 1332.3 1346.9 1374.4 1375.1 1381.9 23705.9 27320.6 28613.3 29070.7 29129.6 46097.3 46299.3 46320.0 46336.3 46385.0 579580.0 583470.0 583472.0 583898.0 584905.0 34466.5 34614.0 35000.3 35173.5 35260.6 40654.0 40699.0 41462.8 41695.0 41815.4 30064.5 34414.0 34415.7 35554.5 35737.1 29044.6 30515.5 33829.7 34382.0 34815.5 34376.3 34414.8 34745.7 34961.0 35106.6 24999.0 28442.1 29026.0 31283.0 31449.7 23400.4 23656.2 23721.8 23940.4 24343.0 07:57:15 INFO - PROCESS | 1641 | 07:57:15 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:33983.80 Median:21684.35 stddev:98939.42 (456.3%) stddev-sans-first:99184.68 07:57:15 INFO - PROCESS | 1641 | Values: 316.4 373.9 374.5 385.8 403.5 13975.1 15255.4 15371.5 15792.4 16205.8 16077.8 16312.1 16379.6 16507.4 17777.6 4894.4 5197.7 5248.1 5252.9 5256.3 2928.5 3704.4 4844.5 5096.8 5124.3 5133.6 5149.5 5155.4 5163.9 5187.1 4948.6 5075.6 5126.2 5132.4 5141.9 4472.2 4532.1 4537.6 4546.6 4560.0 20802.5 21006.2 21148.3 21252.1 21396.4 1993.0 2065.8 2145.0 2147.2 2387.3 12533.6 13208.5 13375.7 13443.5 14029.0 1629.4 1648.1 1680.0 1690.0 1776.3 120276.0 122922.5 125112.0 125904.0 127349.4 9185.9 9495.2 10196.3 10654.6 10805.1 13390.3 13461.5 13467.9 13470.7 13507.7 8000.3 8303.0 8359.0 8378.8 8404.5 8303.9 8316.1 8322.0 8470.0 8503.3 5368.9 6336.3 6359.5 6368.7 6390.4 1461.9 1638.3 1801.0 1803.9 1846.4 810.3 895.8 923.6 950.4 960.5 20930.8 21675.3 21693.3 21777.8 21857.6 869.4 940.2 955.8 976.5 980.8 11062.8 11380.3 11409.0 11546.8 11576.9 578323.0 592653.0 593287.0 598928.0 603784.0 93562.5 114192.0 114407.0 119100.8 123296.0 1019.0 1019.8 1022.2 1043.4 1062.1 16269.5 17053.6 18990.2 19412.4 19475.2 49407.5 52848.7 53201.5 53404.0 53461.0 72820.9 73125.9 73175.0 73598.6 74275.6 7420.8 7605.1 7710.3 7804.7 7813.1 12274.6 12476.6 12478.3 12674.9 12727.2 9325.6 10045.6 10199.8 10674.0 10790.7 10264.7 10475.7 10483.7 10876.3 10913.7 10459.4 10908.3 10976.9 10980.1 11165.0 7709.3 7818.2 7861.8 7887.8 8066.5 7915.3 10535.6 10547.2 10774.5 10835.7 07:57:15 INFO - PROCESS | 1641 | 07:57:15 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5368.44 Median:5183.82 stddev:3025.84 (58.4%) stddev-sans-first:3020.32 07:57:15 INFO - PROCESS | 1641 | Values: 1493.3 1517.6 1550.9 1683.9 1731.4 7229.8 7456.4 7711.1 8146.1 8164.3 7508.8 7737.4 7758.8 7821.8 7851.5 1692.6 2042.4 2044.5 2049.8 2053.0 1880.8 1982.9 2073.0 2086.4 2102.7 2067.6 2067.8 2077.1 2077.4 2107.9 2078.1 2101.8 2106.8 2107.1 2112.8 2093.1 2111.6 2114.9 2117.7 2127.7 7792.0 7870.9 7882.9 7894.0 7945.0 5097.9 5229.4 5250.0 5255.8 5277.7 3352.7 3441.7 3525.6 3589.0 3609.2 955.4 991.3 1025.6 1031.4 1031.8 10978.5 11115.1 11117.4 11137.7 11146.5 3623.0 4627.3 4633.4 4719.9 4806.9 8855.6 8867.7 8871.7 8914.5 8936.7 5116.9 5147.5 5163.9 5180.1 5180.9 4113.5 4775.0 4797.7 4840.1 4867.1 3634.0 3658.9 3704.7 3743.9 3746.0 1148.2 1151.6 1156.0 1160.6 1161.8 691.7 803.6 822.4 832.9 873.9 5186.8 5491.8 5497.7 5669.6 5723.0 885.1 885.1 891.8 932.6 942.3 3631.9 3688.7 3731.8 3807.9 3840.3 9582.4 10265.8 10331.8 10351.2 10359.0 8990.9 9759.6 10147.0 10327.3 10332.3 6831.6 7777.3 7981.9 7991.8 7993.6 5460.3 5491.9 5580.1 5613.2 5675.6 9603.5 9771.3 9796.3 9838.3 9871.4 9597.6 9807.1 9841.6 9950.7 9966.6 6304.2 6484.6 6681.6 6770.1 6883.7 7973.5 7993.6 8201.4 8203.2 8247.4 5679.7 7166.4 7342.2 7385.2 7416.7 7022.9 7114.3 7212.1 7236.8 7269.8 6709.4 6740.7 6796.3 6797.2 6857.3 4839.0 4885.2 4889.7 4906.6 4945.5 4224.2 4548.7 4605.9 4691.9 4882.2 07:57:15 INFO - PROCESS | 1641 | 07:57:15 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4544.44 Median:5107.87 stddev:1404.46 (27.5%) stddev-sans-first:1371.35 07:57:15 INFO - PROCESS | 1641 | Values: 274.6 302.1 305.6 309.3 312.9 4500.7 4590.8 5409.9 5439.8 5451.4 5350.7 5517.0 5542.6 5562.3 5562.3 3388.0 3894.2 3960.9 4283.2 4294.7 3798.7 3859.4 4158.1 4290.8 4315.0 3591.8 3959.2 4101.8 4147.2 4147.8 4102.8 4116.4 4122.0 4142.3 4165.5 3173.3 3293.8 3341.1 3581.6 3599.2 4752.0 5016.9 5025.7 5429.9 5435.2 3750.5 4187.7 4617.7 4812.6 4826.6 5421.9 5825.3 5883.5 5906.7 5939.3 3421.3 3841.1 3898.1 3904.8 3929.9 5393.4 5616.5 5912.5 5977.1 6057.9 3533.9 3705.3 3906.0 3939.7 3982.6 3508.3 4028.1 4066.7 4093.0 4095.1 4044.0 4629.7 4805.4 4814.4 4834.9 5467.8 5650.8 5883.4 5971.6 6031.4 1261.5 1276.1 1292.5 1306.4 1316.5 854.1 882.5 883.3 885.2 891.4 4562.7 4855.0 4953.6 5130.8 5196.7 5171.5 5707.4 5766.9 5770.2 5792.1 4607.0 4681.0 4990.4 5204.8 5273.6 2749.7 2793.5 2796.9 2909.5 2936.5 4777.0 5344.0 5843.8 5864.1 6037.8 5381.9 5554.6 5816.4 5844.4 5962.6 5465.8 5821.8 5898.5 5905.5 5929.8 5379.3 5631.7 5662.7 5671.4 5698.8 4649.5 5179.6 5345.4 5592.7 5598.8 5287.5 5405.4 5768.7 5954.0 5955.9 3614.6 3709.8 3744.4 3785.5 3800.3 5184.4 5285.4 5551.8 5628.0 5643.9 4805.4 5567.7 5606.7 5806.6 6067.9 4804.4 5187.8 5611.9 5822.9 5833.9 5084.9 5238.9 5408.6 5500.5 5636.1 4529.3 4794.8 4896.0 5350.2 5492.9 4717.7 4768.9 5164.8 5676.4 5711.3 07:57:15 INFO - PROCESS | 1641 | 07:57:15 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:20039.41 Median:632.80 stddev:30830.09 (4872.0%) stddev-sans-first:30882.12 07:57:15 INFO - PROCESS | 1641 | Values: 625.3 696.2 696.8 742.9 787.0 13097.2 13783.4 13791.2 13825.6 13829.5 12418.3 12470.1 12525.7 12528.5 12569.4 635.1 653.8 783.4 794.8 811.7 708.3 815.2 815.3 821.0 826.6 855.1 862.0 863.6 865.5 867.0 857.7 858.4 858.9 859.9 862.0 630.5 639.6 639.8 640.2 642.0 11853.0 11947.5 12153.2 12332.2 12343.6 10756.6 10762.6 10847.8 10860.4 11088.7 9395.2 9521.6 9577.3 9587.5 9821.1 3059.5 3081.7 3135.5 3157.4 3160.5 92922.0 97726.0 99059.0 100757.0 101496.0 8275.1 8320.3 8362.1 8503.9 8597.2 16061.8 16793.8 17893.6 18177.4 18211.7 7593.1 7644.7 7681.8 7738.6 7838.7 4180.0 4202.6 4328.8 4401.8 4474.5 3222.1 3255.3 3316.8 3335.6 3340.7 637.1 640.5 644.8 647.3 657.2 539.4 616.6 640.7 659.4 666.6 8307.1 8311.3 8453.2 8833.4 8962.6 603.6 622.6 625.7 641.3 659.0 3799.8 3941.0 4399.0 4407.4 4471.5 75232.5 90742.0 110382.8 111888.0 116007.0 79705.6 91258.0 102975.5 106032.5 107974.5 83794.6 85759.6 92662.5 93302.5 95196.0 8024.9 8524.0 8664.8 8686.8 8791.3 42721.4 51335.5 52306.2 55097.0 56064.7 73380.3 75455.9 75892.6 76837.5 77133.6 10449.1 10466.4 11092.4 11206.4 11304.9 11766.8 12090.5 12171.0 12374.0 12834.4 10090.6 11413.0 11420.6 11554.5 12080.8 11229.8 11404.7 11655.7 11830.6 11966.6 11171.4 11460.9 11638.3 11733.2 11942.4 9369.8 9538.5 9654.3 9745.6 10038.2 6574.7 8972.5 9854.6 9872.4 9896.2 07:57:15 INFO - PROCESS | 1641 | -------- Summary: end -------- 07:57:15 INFO - PROCESS | 1641 | 07:57:15 INFO - TEST-INFO | 1641: exit 0 07:57:15 INFO - TEST-OK | dromaeo_css | took 1116411ms 07:57:15 INFO - TEST-START | kraken 07:57:15 INFO - operating with platform_type : mac_ 07:57:15 INFO - Initialising browser for kraken test... 07:57:15 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp12CfWR/profile http://localhost:49252/getInfo.html) 07:57:18 INFO - PROCESS | 1652 | 2016-11-17 07:57:18.835 plugin-container[1653:10065] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 07:57:18 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:57:18 INFO - PROCESS | 1652 | 2016-11-17 07:57:18.838 plugin-container[1653:10065] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4723, name = 'com.apple.CFPasteboardClient' 07:57:18 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:57:18 INFO - PROCESS | 1652 | 2016-11-17 07:57:18.838 plugin-container[1653:10065] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:57:18 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 07:57:18 INFO - PROCESS | 1652 | colorDepth:24 07:57:18 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 07:57:18 INFO - PROCESS | 1652 | __metrics 07:57:19 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 07:57:19 INFO - TEST-INFO | 1652: exit 0 07:57:19 INFO - Browser initialized. 07:57:19 INFO - Running cycle 1/1 for kraken test... 07:57:19 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp12CfWR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:22 INFO - PROCESS | 1654 | 2016-11-17 07:57:22.262 plugin-container[1655:10184] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 07:57:22 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:57:22 INFO - PROCESS | 1654 | 2016-11-17 07:57:22.263 plugin-container[1655:10184] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 07:57:22 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:57:22 INFO - PROCESS | 1654 | 2016-11-17 07:57:22.263 plugin-container[1655:10184] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:57:31 INFO - PROCESS | 1654 | RSS: Main: 238096384 07:57:31 INFO - PROCESS | 1654 | 07:57:35 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:36 INFO - PROCESS | 1654 | RSS: Main: 250548224 07:57:36 INFO - PROCESS | 1654 | 07:57:38 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-dft) 07:57:39 INFO - PROCESS | 1654 | RSS: Main: 258195456 07:57:39 INFO - PROCESS | 1654 | 07:57:42 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-fft) 07:57:43 INFO - PROCESS | 1654 | RSS: Main: 260935680 07:57:43 INFO - PROCESS | 1654 | 07:57:45 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator) 07:57:46 INFO - PROCESS | 1654 | RSS: Main: 262148096 07:57:46 INFO - PROCESS | 1654 | 07:57:48 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:48 INFO - PROCESS | 1654 | RSS: Main: 262443008 07:57:48 INFO - PROCESS | 1654 | 07:57:51 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:52 INFO - PROCESS | 1654 | RSS: Main: 267067392 07:57:52 INFO - PROCESS | 1654 | 07:57:55 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:56 INFO - PROCESS | 1654 | RSS: Main: 267071488 07:57:56 INFO - PROCESS | 1654 | 07:57:59 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial) 07:57:59 INFO - PROCESS | 1654 | RSS: Main: 268505088 07:57:59 INFO - PROCESS | 1654 | 07:58:01 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:02 INFO - PROCESS | 1654 | RSS: Main: 267563008 07:58:02 INFO - PROCESS | 1654 | 07:58:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:04 INFO - PROCESS | 1654 | RSS: Main: 267485184 07:58:04 INFO - PROCESS | 1654 | 07:58:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:07 INFO - PROCESS | 1654 | RSS: Main: 267599872 07:58:07 INFO - PROCESS | 1654 | 07:58:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:11 INFO - PROCESS | 1654 | RSS: Main: 267890688 07:58:11 INFO - PROCESS | 1654 | 07:58:14 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:15 INFO - PROCESS | 1654 | RSS: Main: 267747328 07:58:15 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49252/tests/kraken/driver.html?testName=ai-astar) 07:58:17 INFO - PROCESS | 1654 | RSS: Main: 270880768 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | __start_tp_report 07:58:17 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 07:58:17 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 07:58:17 INFO - PROCESS | 1654 | |i|pagename|runs| 07:58:17 INFO - PROCESS | 1654 | |0;ai-astar;108;119;117;126;131;116;122;174;165;117 07:58:17 INFO - PROCESS | 1654 | |1;audio-beat-detection;140;134;99;152;114;108;138;147;178;122 07:58:17 INFO - PROCESS | 1654 | |2;audio-dft;205;250;178;263;278;204;194;196;208;195 07:58:17 INFO - PROCESS | 1654 | |3;audio-fft;80;60;60;96;57;81;83;83;70;77 07:58:17 INFO - PROCESS | 1654 | |4;audio-oscillator;81;72;87;73;71;60;113;61;74;120 07:58:17 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;91;88;90;87;90;87;91;89;91;86 07:58:17 INFO - PROCESS | 1654 | |6;imaging-darkroom;99;116;169;127;149;169;139;101;100;99 07:58:17 INFO - PROCESS | 1654 | |7;imaging-desaturate;94;102;146;92;143;142;103;92;93;86 07:58:17 INFO - PROCESS | 1654 | |8;json-parse-financial;57;56;59;56;59;59;58;58;56;58 07:58:17 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;71;59;85;115;109;101;98;72;70;70 07:58:17 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;93;89;91;92;88;90;99;89;90;109 07:58:17 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;157;162;157;162;173;159;164;170;203;162 07:58:17 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;179;177;182;177;178;172;168;153;218;235 07:58:17 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;67;69;69;72;74;94;91;88;92;92 07:58:17 INFO - PROCESS | 1654 | __end_tp_report 07:58:17 INFO - PROCESS | 1654 | __start_cc_report 07:58:17 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,969 07:58:17 INFO - PROCESS | 1654 | __end_cc_report 07:58:17 INFO - PROCESS | 1654 | __startTimestamp1479398297314__endTimestamp 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | ------- Summary: start ------- 07:58:17 INFO - PROCESS | 1654 | Number of tests: 14 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:129.50 Median:124.00 stddev:22.06 (17.8%) stddev-sans-first:21.98 07:58:17 INFO - PROCESS | 1654 | Values: 108.0 119.0 117.0 126.0 131.0 116.0 122.0 174.0 165.0 117.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:143.50 stddev:23.38 (16.3%) stddev-sans-first:24.67 07:58:17 INFO - PROCESS | 1654 | Values: 140.0 134.0 99.0 152.0 114.0 108.0 138.0 147.0 178.0 122.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:217.10 Median:206.50 stddev:33.82 (16.4%) stddev-sans-first:35.59 07:58:17 INFO - PROCESS | 1654 | Values: 205.0 250.0 178.0 263.0 278.0 204.0 194.0 196.0 208.0 195.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:74.70 Median:80.50 stddev:12.61 (15.7%) stddev-sans-first:13.23 07:58:17 INFO - PROCESS | 1654 | Values: 80.0 60.0 60.0 96.0 57.0 81.0 83.0 83.0 70.0 77.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:81.20 Median:72.50 stddev:20.32 (28.0%) stddev-sans-first:21.55 07:58:17 INFO - PROCESS | 1654 | Values: 81.0 72.0 87.0 73.0 71.0 60.0 113.0 61.0 74.0 120.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:90.00 stddev:1.89 (2.1%) stddev-sans-first:1.86 07:58:17 INFO - PROCESS | 1654 | Values: 91.0 88.0 90.0 87.0 90.0 87.0 91.0 89.0 91.0 86.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:126.80 Median:159.00 stddev:28.38 (17.9%) stddev-sans-first:28.26 07:58:17 INFO - PROCESS | 1654 | Values: 99.0 116.0 169.0 127.0 149.0 169.0 139.0 101.0 100.0 99.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:109.30 Median:89.00 stddev:24.24 (27.2%) stddev-sans-first:25.06 07:58:17 INFO - PROCESS | 1654 | Values: 94.0 102.0 146.0 92.0 143.0 142.0 103.0 92.0 93.0 86.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.26 (2.2%) stddev-sans-first:1.32 07:58:17 INFO - PROCESS | 1654 | Values: 57.0 56.0 59.0 56.0 59.0 59.0 58.0 58.0 56.0 58.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:85.00 Median:70.50 stddev:19.41 (27.5%) stddev-sans-first:19.92 07:58:17 INFO - PROCESS | 1654 | Values: 71.0 59.0 85.0 115.0 109.0 101.0 98.0 72.0 70.0 70.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:93.00 Median:90.50 stddev:6.43 (7.1%) stddev-sans-first:6.82 07:58:17 INFO - PROCESS | 1654 | Values: 93.0 89.0 91.0 92.0 88.0 90.0 99.0 89.0 90.0 109.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:166.90 Median:163.00 stddev:13.70 (8.4%) stddev-sans-first:14.05 07:58:17 INFO - PROCESS | 1654 | Values: 157.0 162.0 157.0 162.0 173.0 159.0 164.0 170.0 203.0 162.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.90 Median:178.50 stddev:24.22 (13.6%) stddev-sans-first:25.63 07:58:17 INFO - PROCESS | 1654 | Values: 179.0 177.0 182.0 177.0 178.0 172.0 168.0 153.0 218.0 235.0 07:58:17 INFO - PROCESS | 1654 | 07:58:17 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.80 Median:89.50 stddev:11.42 (12.8%) stddev-sans-first:10.97 07:58:17 INFO - PROCESS | 1654 | Values: 67.0 69.0 69.0 72.0 74.0 94.0 91.0 88.0 92.0 92.0 07:58:17 INFO - PROCESS | 1654 | -------- Summary: end -------- 07:58:17 INFO - PROCESS | 1654 | 07:58:18 INFO - TEST-INFO | 1654: exit 0 07:58:18 INFO - TEST-OK | kraken | took 62178ms 07:58:18 INFO - SUITE-END | took 1178s 07:58:18 INFO - Completed test suite (00:19:38) 07:58:18 INFO - javascript benchmark 07:58:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6919.299314812367, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2830.900918467854, 3158.0999415166684, 3211.2293049668087, 3299.8020118792865, 3387.1532116970757, 5360.705161216131, 5645.661260324373, 5713.942860571398, 5747.224124743158, 5827.329857066438, 5683.772649094041, 5734.082546792514, 5755.366909639947, 5833.912491312633, 5903.409659034094, 5164.50937160971, 5178.40448348441, 5214.217867319894, 5290.7354632268425, 5371.435999220084, 5344.518993290603, 5349.491798279158, 5364.0, 5379.515843574078, 5419.512243898049, 5156.664816786934, 5289.233061206142, 5293.814716484904, 5304.734763261841, 5305.840824775243, 5194.896102077937, 5249.947500524984, 5297.046531624306, 5300.628955973083, 5315.255864179018, 5181.35233095863, 5193.63644544882, 5210.557102646279, 5235.005348983719, 5255.106631872591, 5656.0, 5723.656580605136, 5735.996200664908, 5808.8838223235725, 5886.793962211302, 5485.424030476783, 5932.584719069667, 6104.610739188311, 6131.3868613138775, 6132.294786099611, 6194.0, 6195.969020154916, 6200.0, 6200.100985357143, 6213.5339849511465, 5792.855178620568, 5950.702464876739, 5961.701914904281, 5968.7015649217365, 5989.520838332923, 6124.075808605272, 6139.10982907476, 6177.227846519185, 6187.969060154761, 6207.875842483125, 6111.561351782648, 6127.80043271483, 6136.325004249529, 6170.969145154246, 6194.225721784777, 5202.505761952609, 6101.328853826076, 6178.66017369049, 6187.783427580103, 6193.597416167935, 4764.690295130806, 5866.002779527491, 6124.411449639965, 6136.079588061737, 6138.878900475427, 6089.391060893875, 6095.969520152371, 6128.5359331975715, 6137.84655383619, 6162.691865406801, 3932.6067393260446, 4963.230699241623, 4986.301917731521, 4989.875253118628, 4994.90010199794, 4415.867523974286, 4431.357453169337, 4460.799264033127, 4461.776911154429, 4474.127545128668, 5877.941220587825, 5920.2895652521975, 5948.821535353946, 5991.3409524953095, 6005.669688167105, 6162.630242185483, 6175.011998080286, 6196.938030619726, 6197.81406557795, 6201.782937597162, 5974.163617093611, 6027.367126451747, 6036.0644100164545, 6053.576249662481, 6066.332703402622, 5349.063913815145, 5405.297311349499, 5418.647787893774, 5470.753816078286, 5475.0, 5340.412554618911, 6211.13044173807, 6237.345078766664, 6247.156633854372, 6262.342454042351, 6129.877402452015, 6143.815685529441, 6155.446009859134, 6159.19930409044, 6159.538034647329, 6263.906041409291, 6319.399657032574, 6342.968285158545, 6355.491560675227, 6356.078368636429, 6042.425969532887, 6115.021596544531, 6120.995732433061, 6123.357047509948, 6130.049842274455, 6133.570650054453, 6150.938490615036, 6156.907646385218, 6174.722137503733, 6174.845628859314, 5993.31076926159, 6008.24896887889, 6069.787557435468, 6131.509479241739, 6138.693065346804, 6115.209918062534, 6131.743695906945, 6132.845047373448, 6139.508839292756, 6158.876822463615, 5180.870478238075, 5752.884942301214, 5984.251968503937, 6052.334243233329, 6079.939200608114, 6004.459598636144, 6066.575339726353, 6094.055421409511, 6103.389661034039, 6167.969160154171, 6005.6396616203165, 6007.729652165751, 6015.518758499397, 6026.909596356146, 6027.728752206073], "value": 5678.304730081225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.24130150457756, 480.0950208856305, 483.9346688197093, 500.09982032341776, 511.7390131033172, 28745.56881646777, 32539.349213015725, 32721.99999999997, 34073.0, 34182.48726269108, 32509.0, 32816.34367312658, 32874.34251314972, 32894.01317960459, 32998.50502242468, 7194.676239569232, 7359.227281135484, 7365.705371785122, 7372.483926125174, 7386.4460165487535, 7517.285857843523, 7596.278353556431, 7601.429892758038, 7605.467617266793, 7610.972518709958, 6036.577439579231, 6703.1956165260235, 7260.564366138048, 7630.809229769273, 7646.885296720554, 7578.090629124513, 7605.657745401415, 7610.429217808659, 7618.123915749649, 7642.3121919027, 7554.320111189964, 7569.583672897988, 7665.156832748393, 7669.348105411047, 7688.500247483896, 30688.693113069032, 30774.38451230985, 30926.381472370427, 31046.84476577625, 31092.222694432596, 3329.234276116507, 3340.5657264555452, 3345.3643807676463, 3403.3193361327835, 3467.6705712957228, 20723.0, 20873.89563052175, 21026.47433814167, 21429.67855482169, 21508.247211347527, 2430.6718592989896, 2738.86305684715, 2811.1004478566865, 2851.9429611407654, 2855.0, 468911.0, 474426.0, 475509.0, 476140.0, 477822.0, 55390.72304638451, 55515.444845551836, 55604.72197639067, 55751.721241393534, 55786.72106639522, 55663.165052524244, 56848.147277790864, 57397.42602573921, 57666.55833604193, 57758.422415775305, 15282.465113720966, 15466.5360039199, 15487.457938972082, 15498.767518487231, 15505.534833954775, 12128.090393220544, 12162.756744865053, 12196.39018049094, 12211.877881221251, 12234.938825305995, 14500.0, 14836.777448338284, 14901.254937253094, 15007.849921500645, 15177.0, 5585.413531579207, 5703.9429605704245, 6584.703688333941, 6677.699503522256, 6692.364225398676, 851.6678495386805, 891.6388862510694, 936.9672061477816, 961.8172547216006, 1037.7820657661825, 28496.28759280993, 28995.275118121794, 29191.56212656812, 29420.411591768472, 29833.552496712568, 942.1144124522926, 1025.8307379282335, 1095.4358505369742, 1131.3607811586428, 1217.452146534063, 14169.504067357593, 14470.421183152766, 14663.853361466248, 14776.92611536957, 14942.0, 638320.0, 642698.0, 643805.0, 644088.0, 644998.0, 49587.752061240186, 49994.75002624963, 50181.0, 50240.7247239042, 50247.24134655269, 1332.2739107186605, 1346.9326533673277, 1374.4296117111287, 1375.0924389902616, 1381.8687224713635, 23705.881470592536, 27320.590191147545, 28613.28466788347, 29070.7092929068, 29129.56305655459, 46097.308540371254, 46299.3055104167, 46320.0, 46336.304955425025, 46385.0, 579580.0, 583470.0, 583472.0, 583898.0, 584905.0, 34466.483002754474, 34613.96158115261, 35000.29999399947, 35173.53785235009, 35260.647393526764, 40653.983650408976, 40699.0, 41462.79268603637, 41694.95762605959, 41815.37276940788, 30064.549031764105, 34414.0, 34415.65584344225, 35554.46668300029, 35737.1065723359, 29044.56433153547, 30515.542266866458, 33829.66170338265, 34382.0, 34815.47776783401, 34376.312473750884, 34414.82792586021, 34745.65254347424, 34960.9511714649, 35106.64893351136, 24999.0, 28442.146735597966, 29026.0, 31283.0, 31449.685503144676, 23400.414989625395, 23656.172033978728, 23721.762782371956, 23940.40148996289, 24343.0], "value": 17794.530572435324, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.42884593309077, 373.92708421857714, 374.5280946008029, 385.82059342405773, 403.4976454314379, 13975.091619044755, 15255.389784408624, 15371.461998830044, 15792.44726434575, 16205.83794162058, 16077.758833617505, 16312.102834344107, 16379.59051023725, 16507.422240221596, 17777.555561110978, 4894.412670479539, 5197.662151960129, 5248.107821670325, 5252.8686782830355, 5256.316678831747, 2928.487514684932, 3704.407294832827, 4844.5155484451625, 5096.79612815487, 5124.256982737501, 5133.614978876581, 5149.459306772791, 5155.355580552431, 5163.896722065557, 5187.1181899077055, 4948.604111671076, 5075.6447048706605, 5126.179811230222, 5132.435432102466, 5141.871453213681, 4472.1502914446155, 4532.116237333721, 4537.591616754475, 4546.590806827401, 4560.019595786888, 20802.47993800152, 21006.159753609838, 21148.259810906544, 21252.14991400342, 21396.358109256747, 1992.9736185864292, 2065.7624373197123, 2145.03473436954, 2147.2377306056437, 2387.307680772574, 12533.623991280276, 13208.537701180412, 13375.665608359772, 13443.462261509529, 14029.017968742191, 1629.413411171977, 1648.0606054548912, 1679.9748003779953, 1689.9746503802453, 1776.253973331204, 120276.0, 122922.54220456802, 125112.0, 125904.0, 127349.36325318407, 9185.943616484055, 9495.24038076966, 10196.286259961731, 10654.643787207006, 10805.081568066802, 13390.26353550564, 13461.461541538425, 13467.865321346857, 13470.730585388434, 13507.662308442368, 8000.271097168886, 8302.958485207535, 8359.0, 8378.790530236793, 8404.537750423664, 8303.916960830315, 8316.126806685332, 8322.042965058974, 8470.025947016173, 8503.277221436247, 5368.8657783554945, 6336.303006669263, 6359.523035772243, 6368.745250189941, 6390.392912673288, 1461.9122852628877, 1638.270969418621, 1800.9729854051939, 1803.9007854567863, 1846.4460661801675, 810.2869474862084, 895.789489469974, 923.6028507741736, 950.3585080071063, 960.500539719342, 20930.790692092884, 21675.34973950784, 21693.34919952404, 21777.78222217789, 21857.562848743255, 869.443556124081, 940.191435365585, 955.7992821507422, 976.4531862157214, 980.7891303369667, 11062.834057489144, 11380.317180969168, 11409.0, 11546.826797598043, 11576.942115289537, 578323.0, 592653.0, 593287.0, 598928.0, 603784.0, 93562.53218733863, 114192.0, 114407.0, 119100.8089919107, 123296.0, 1018.994905025485, 1019.8215312320315, 1022.223110436074, 1043.3896170740202, 1062.1396668698378, 16269.51191464258, 17053.57366065858, 18990.24039038478, 19412.417627471197, 19475.2163416159, 49407.50592494173, 52848.73575632097, 53201.4679853212, 53404.0, 53461.0, 72820.9076863858, 73125.90311145231, 73175.0, 73598.63200683962, 74275.62862185655, 7420.814479638052, 7605.125410577854, 7710.267524585155, 7804.6878124874365, 7813.1405545388825, 12274.570390036306, 12476.625701228977, 12478.313692746622, 12674.873251267369, 12727.23636581808, 9325.580348884452, 10045.648402305884, 10199.84700229512, 10674.039336459446, 10790.67627971162, 10264.692059238234, 10475.738106547396, 10483.68548943533, 10876.293040952312, 10913.727156821144, 10459.372437653765, 10908.34549927007, 10976.945115274373, 10980.066694331072, 11164.9951504365, 7709.306162445407, 7818.17909119557, 7861.803454913673, 7887.763367098996, 8066.475679080841, 7915.287624113857, 10535.631252906418, 10547.208959328234, 10774.46127693628, 10835.729106772395], "value": 9067.197481008094, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.3280023989207, 1517.5902506323293, 1550.875929925606, 1683.8970474339305, 1731.3940120957675, 7229.7831065068, 7456.440766942487, 7711.113221979467, 8146.103928567868, 8164.306033987111, 7508.81227969301, 7737.381009519239, 7758.806029849256, 7821.843563128748, 7851.528908265494, 1692.6360832420996, 2042.3974927396453, 2044.4684382060623, 2049.7847725988704, 2053.035073515445, 1880.8213219744102, 1982.9093998300948, 2072.9585408291823, 2086.394945465813, 2102.6740855167473, 2067.627826991141, 2067.782882797307, 2077.1276064053136, 2077.366403247009, 2107.924958271285, 2078.1064142418754, 2101.821345185661, 2106.810387065164, 2107.093949601671, 2112.7570329412006, 2093.079045220098, 2111.609352269835, 2114.904829282686, 2117.74587049555, 2127.659574468093, 7791.961040194819, 7870.921290787133, 7882.881756773653, 7894.0, 7944.960275198645, 5097.9490205097845, 5229.424763276036, 5249.973750131263, 5255.789768409259, 5277.736113194325, 3352.7485438591957, 3441.724662027057, 3525.6298088700573, 3588.9641103588892, 3609.2420591675777, 955.4219697083234, 991.3308516751237, 1025.5897640943608, 1031.3760175094035, 1031.829748091564, 10978.451077446096, 11115.11079113677, 11117.444127793578, 11137.665870023913, 11146.498407571678, 3623.0, 4627.329037289574, 4633.374494443275, 4719.882002949954, 4806.855794326176, 8855.601497932608, 8867.689630863018, 8871.733847984571, 8914.509701966454, 8936.687215947411, 5116.948830511647, 5147.510986456281, 5163.948360516422, 5180.067587834226, 5180.870478238075, 4113.4858142732155, 4775.044991001813, 4797.712137271775, 4840.128776820206, 4867.075255701406, 3633.9818300908855, 3658.9451158232646, 3704.722145839019, 3743.9142648632137, 3746.0260332313796, 1148.2019996102795, 1151.585429245471, 1155.96532104037, 1160.5995931403652, 1161.7560312334335, 691.7440546997643, 803.6263137640908, 822.3667775812711, 832.9130484717381, 873.868919662043, 5186.766595503212, 5491.807786727445, 5497.725113744297, 5669.6314739541795, 5723.0, 885.1016218538189, 885.1104639836923, 891.7592250092439, 932.6083045121065, 942.2603256443659, 3631.927361452809, 3688.686461650736, 3731.7574357666663, 3807.8857634271017, 3840.347140986039, 9582.425054496753, 10265.794684106277, 10331.845022324671, 10351.171906247482, 10359.015893490106, 8990.921089469175, 9759.609615615296, 10147.0, 10327.32872363294, 10332.328398654214, 6831.555948863407, 7777.338926191337, 7981.920180798234, 7991.800204994805, 7993.600319983978, 5460.34475862899, 5491.917621235605, 5580.135079062752, 5613.214150019082, 5675.602707810413, 9603.519824008912, 9771.316007879665, 9796.314258001872, 9838.262130340396, 9871.358361706467, 9597.568109434953, 9807.06832850878, 9841.557129929028, 9950.701478955643, 9966.604675345603, 6304.243490781136, 6484.643344615903, 6681.632510211985, 6770.086038384952, 6883.724651013903, 7973.481723687942, 7993.600319984093, 8201.384896132695, 8203.179682031749, 8247.381446391424, 5679.716014199191, 7166.390856777232, 7342.192358840416, 7385.187629360874, 7416.66625001887, 7022.859542809218, 7114.324139206767, 7212.134543854771, 7236.782896513113, 7269.818254543678, 6709.36261055199, 6740.6966686498245, 6796.320367963164, 6797.150356205474, 6857.348551887562, 4838.975805120952, 4885.2427873679635, 4889.657723959289, 4906.55840974314, 4945.505449455026, 4224.218519573888, 4548.703619468568, 4605.884852878705, 4691.859244222679, 4882.169186555042], "value": 4293.576261859297, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.56481476859165, 302.14342339467606, 305.5920346337639, 309.3364732648469, 312.8560862003478, 4500.729956202626, 4590.770461476921, 5409.889313644655, 5439.782408703652, 5451.427600101992, 5350.678959262447, 5516.951779161956, 5542.5565954723625, 5562.3047119110115, 5562.3047119110115, 3388.0, 3894.1822217334393, 3960.940585891207, 4283.229018776619, 4294.656427485794, 3798.65812076913, 3859.36320507116, 4158.087279851272, 4290.76400797956, 4314.956850431503, 3591.7844929304197, 3959.2477429288488, 4101.826032202922, 4147.232761939051, 4147.813348399314, 4102.815373308208, 4116.403121547389, 4122.0107174277955, 4142.2543942090415, 4165.45849039626, 3173.2701478660038, 3293.7859039162377, 3341.1313058604937, 3581.606023337431, 3599.236374176661, 4752.049590081998, 5016.871203979112, 5025.7235852028125, 5429.864253393657, 5435.1520483035565, 3750.5124333836698, 4187.748735075875, 4617.72293662378, 4812.614990800727, 4826.638002149853, 5421.918671219935, 5825.271841019872, 5883.470487656089, 5906.700525884342, 5939.346671866091, 3421.298633780094, 3841.058940559553, 3898.083950271684, 3904.7657140571655, 3929.941050884239, 5393.4336894626285, 5616.466435688603, 5912.497437717756, 5977.073553599155, 6057.9398605243905, 3533.911652208715, 3705.333040052816, 3906.0, 3939.6651284641125, 3982.601739825994, 3508.298475239507, 4028.099768166915, 4066.698656429914, 4092.9795351023054, 4095.0990782027907, 4044.0, 4629.699069560468, 4805.423349198119, 4814.352106341568, 4834.854954351375, 5467.753951072212, 5650.802221922213, 5883.382244864228, 5971.641701497924, 6031.396860313934, 1261.5332327039055, 1276.074845736852, 1292.4894666606638, 1306.405585458614, 1316.4799904038043, 854.0775961961067, 882.5234373438271, 883.2933653077512, 885.1723638398119, 891.4116682989196, 4562.657800664963, 4854.975725121351, 4953.6037117030555, 5130.820421285312, 5196.714180720097, 5171.50870667286, 5707.429257074343, 5766.86748793574, 5770.153550863767, 5792.102224155178, 4606.953930460652, 4681.040386720714, 4990.4011518618, 5204.769206946994, 5273.630845840831, 2749.7250274972344, 2793.52510073288, 2796.944061118766, 2909.461749576335, 2936.456755500239, 4776.976115119472, 5343.973280133652, 5843.766249350064, 5864.120381942743, 6037.818865434044, 5381.865453363619, 5554.638948468337, 5816.360200377955, 5844.357120716718, 5962.612430192024, 5465.836024919259, 5821.767129314865, 5898.528117750569, 5905.52755779528, 5929.762809487572, 5379.327584051994, 5631.6902570359025, 5662.697579556642, 5671.355306960935, 5698.8290351289525, 4649.465311489087, 5179.611529135405, 5345.412004679404, 5592.692401917933, 5598.836657288619, 5287.524122828964, 5405.432429594836, 5768.7404066817935, 5953.970230148821, 5955.937453164948, 3614.6385361463645, 3709.8145092744717, 3744.382176940774, 3785.4700341951598, 3800.3159431301524, 5184.351956005499, 5285.418603953485, 5551.805686800943, 5628.015097358028, 5643.858903527444, 4805.399325084364, 5567.693776842312, 5606.6636001840025, 5806.603137164806, 6067.876243314981, 4804.4357860032405, 5187.766550505161, 5611.915821262766, 5822.942954948686, 5833.941660583339, 5084.923726144185, 5238.869028274324, 5408.621396502364, 5500.532454741392, 5636.083731531299, 4529.252673308867, 4794.7842347093765, 4896.041583366682, 5350.170723537858, 5492.890142197213, 4717.69334993238, 4768.854015692883, 5164.845054648366, 5676.375598684224, 5711.257536520226], "value": 4092.623082883377, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.2996643758988, 696.2376198063121, 696.8257935516122, 742.8737114690502, 786.9999999999998, 13097.214167149967, 13783.379747911344, 13791.172529648227, 13825.58523244303, 13829.515966941146, 12418.254904705702, 12470.064745144127, 12525.749485010294, 12528.49886004561, 12569.434375453104, 635.0632816595531, 653.7581094994835, 783.3615603283334, 794.7973266816954, 811.6834434570522, 708.3270892651975, 815.1888870573788, 815.2744057788573, 820.9507429554216, 826.6197549127409, 855.1363123245536, 861.9870701939476, 863.5639002303827, 865.4547634989948, 866.9826603467958, 857.7126662568047, 858.3819649852096, 858.9226969572737, 859.9011113721876, 861.9699459146354, 630.5460068750538, 639.5842702243532, 639.808057582728, 640.2445114764575, 642.0048924167568, 11853.0, 11947.462364193632, 12153.210041347284, 12332.19840710351, 12343.629691109281, 10756.569737210502, 10762.623308184176, 10847.837282440769, 10860.402677852715, 11088.722781930435, 9395.154436100784, 9521.57152928113, 9577.329586928918, 9587.472689002103, 9821.116099551075, 3059.5410688396696, 3081.7072378124044, 3135.513995330705, 3157.431662300785, 3160.541721450377, 92922.0, 97726.0, 99059.0188196232, 100756.99999999927, 101496.0, 8275.08974012858, 8320.251177394064, 8362.12197719243, 8503.914960850436, 8597.18326758957, 16061.839381606269, 16793.832061679226, 17893.552661183316, 18177.363792267206, 18211.72682409765, 7593.088829340514, 7644.732434364771, 7681.807954801175, 7738.574378409242, 7838.725644602411, 4180.0, 4202.621764041251, 4328.783560821947, 4401.823927042882, 4474.463064432289, 3222.113918672384, 3255.251292202807, 3316.8009919404913, 3335.6497567755523, 3340.7160391367006, 637.1048676609371, 640.5324113397246, 644.8484606117559, 647.3429469088878, 657.1850904877917, 539.3931826694968, 616.6485103490967, 640.7052755732323, 659.3867703036223, 666.620026584842, 8307.050463110842, 8311.33509319253, 8453.154684531497, 8833.381663283508, 8962.596683149273, 603.6287683074966, 622.5735371270604, 625.6621424430847, 641.3330136657823, 658.9637569933603, 3799.772013679188, 3941.034446560611, 4398.978005109954, 4407.382966384709, 4471.463424389029, 75232.4953500927, 90742.0, 110382.79234415427, 111888.0, 116007.0, 79705.60147199227, 91258.0, 102975.48512257541, 106032.46983765032, 107974.46012769885, 83794.58102709448, 85759.57120214484, 92662.53668731613, 93302.53348733348, 95196.0, 8024.919750802417, 8523.957380213307, 8664.82670346577, 8686.82626347482, 8791.34064945119, 42721.35917961171, 51335.486645134566, 52306.16928407487, 55097.04126628623, 56064.71967640136, 73380.26619733735, 75455.86816197651, 75892.62053689697, 76837.46325073355, 77133.61433192798, 10449.05958463742, 10466.424346661006, 11092.389918554234, 11206.38364889939, 11304.886951130384, 11766.82349764737, 12090.455929483018, 12171.0, 12374.0, 12834.358282085672, 10090.646132778831, 11413.029892458902, 11420.600278990196, 11554.480048397674, 12080.818787718366, 11229.831552526883, 11404.714882128013, 11655.708607284885, 11830.585929492427, 11966.64100076999, 11171.385573793194, 11460.885391145981, 11638.301701897914, 11733.178677492835, 11942.402879856147, 9369.81260374775, 9538.475383853676, 9654.27592930519, 9745.610175592898, 10038.196944244297, 6574.704138313692, 8972.506512141896, 9854.605815767289, 9872.40765554069, 9896.158826499828], "value": 6816.01137647928, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1628.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 119.0, 117.0, 126.0, 131.0, 116.0, 122.0, 174.0, 165.0, 117.0], "value": 129.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 99.0, 152.0, 114.0, 108.0, 138.0, 147.0, 178.0, 122.0], "value": 133.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 250.0, 178.0, 263.0, 278.0, 204.0, 194.0, 196.0, 208.0, 195.0], "value": 217.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 96.0, 57.0, 81.0, 83.0, 83.0, 70.0, 77.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 72.0, 87.0, 73.0, 71.0, 60.0, 113.0, 61.0, 74.0, 120.0], "value": 81.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 90.0, 87.0, 90.0, 87.0, 91.0, 89.0, 91.0, 86.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 116.0, 169.0, 127.0, 149.0, 169.0, 139.0, 101.0, 100.0, 99.0], "value": 126.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 102.0, 146.0, 92.0, 143.0, 142.0, 103.0, 92.0, 93.0, 86.0], "value": 109.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 59.0, 56.0, 59.0, 59.0, 58.0, 58.0, 56.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 59.0, 85.0, 115.0, 109.0, 101.0, 98.0, 72.0, 70.0, 70.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 89.0, 91.0, 92.0, 88.0, 90.0, 99.0, 89.0, 90.0, 109.0], "value": 93.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 162.0, 157.0, 162.0, 173.0, 159.0, 164.0, 170.0, 203.0, 162.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 182.0, 177.0, 178.0, 172.0, 168.0, 153.0, 218.0, 235.0], "value": 183.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 72.0, 74.0, 94.0, 91.0, 88.0, 92.0, 92.0], "value": 80.8, "unit": "score"}]}]} 07:58:18 INFO - Return code: 0 07:58:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:58:18 ERROR - # TBPL SUCCESS # 07:58:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:58:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:58:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:58:18 INFO - 2016-11-17 07:58:18.620 screenresolution[1659:10570] starting screenresolution argv=screenresolution get 07:58:18 INFO - 2016-11-17 07:58:18.623 screenresolution[1659:10570] Display 0: 1600x1200x32@60 07:58:18 INFO - 2016-11-17 07:58:18.629 screenresolution[1660:10573] starting screenresolution argv=screenresolution list 07:58:18 INFO - Available Modes on Display 0 07:58:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:58:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:58:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:58:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:58:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:58:18 INFO - Intel Iris: 07:58:18 INFO - Chipset Model: Intel Iris 07:58:18 INFO - Type: GPU 07:58:18 INFO - Bus: Built-In 07:58:18 INFO - VRAM (Dynamic, Max): 1536 MB 07:58:18 INFO - Vendor: Intel (0x8086) 07:58:18 INFO - Device ID: 0x0a2e 07:58:18 INFO - Revision ID: 0x0009 07:58:18 INFO - Displays: 07:58:18 INFO - Display: 07:58:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:58:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:58:18 INFO - Display Serial Number: 1600x1200 60 07:58:18 INFO - Main Display: Yes 07:58:18 INFO - Mirror: Off 07:58:18 INFO - Online: Yes 07:58:18 INFO - Rotation: Supported 07:58:18 INFO - Return code: 0 07:58:18 INFO - Running post-action listener: _resource_record_post_action 07:58:18 INFO - [mozharness: 2016-11-17 15:58:18.863652Z] Finished run-tests step (success) 07:58:18 INFO - Running post-run listener: _resource_record_post_run 07:58:18 INFO - Total resource usage - Wall time: 1213s; CPU: 55.0%; Read bytes: 39606784; Write bytes: 704999936; Read time: 383; Write time: 1966 07:58:18 INFO - TinderboxPrint: CPU usage
54.8% 07:58:18 INFO - TinderboxPrint: I/O read bytes / time
39,606,784 / 383 07:58:18 INFO - TinderboxPrint: I/O write bytes / time
704,999,936 / 1,966 07:58:18 INFO - TinderboxPrint: CPU idle
2,193.2 (45.2%) 07:58:18 INFO - TinderboxPrint: CPU system
985.4 (20.3%) 07:58:18 INFO - TinderboxPrint: CPU user
1,675.1 (34.5%) 07:58:18 INFO - TinderboxPrint: Swap in / out
452,157,440 / 0 07:58:18 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 378966528; Write bytes: 374996480; Read time: 28077; Write time: 751 07:58:18 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 38685184; Write bytes: 301118464; Read time: 369; Write time: 1151 07:58:19 INFO - Running post-run listener: _upload_blobber_files 07:58:19 INFO - Blob upload gear active. 07:58:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:19 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 07:58:19 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:58:19 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:58:19 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:58:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:58:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:20 INFO - (blobuploader) - INFO - Done attempting. 07:58:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:58:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:58:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:21 INFO - (blobuploader) - INFO - Done attempting. 07:58:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:58:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:58:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:23 INFO - (blobuploader) - INFO - Done attempting. 07:58:23 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:23 INFO - Return code: 0 07:58:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1140890440b51d1ead3ce9b41acdbdd102876660897f8f462e8434bfbb9aa2270baef180591e54fe8b5609794838c8877c84d1bc37f5d32721ac55a9a40e204", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3382949580eed1e4f370359388bd4f0b6067a48d3f6a44254a13a873e4243e3967593199b3c758ca9891861df3ac470143522b24a6f02312f29008efac5c49ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d9805dacd7c0eccb650d6554efb9b1ec2ef8c7111e4be2ff8a3c30c57880bd7b60fd5435ca371a56dbd960fb6f42d5c8b9e2ab78cc8c4dc69e6850ac2e4c5c0"} 07:58:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:23 INFO - Contents: 07:58:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1140890440b51d1ead3ce9b41acdbdd102876660897f8f462e8434bfbb9aa2270baef180591e54fe8b5609794838c8877c84d1bc37f5d32721ac55a9a40e204", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3382949580eed1e4f370359388bd4f0b6067a48d3f6a44254a13a873e4243e3967593199b3c758ca9891861df3ac470143522b24a6f02312f29008efac5c49ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d9805dacd7c0eccb650d6554efb9b1ec2ef8c7111e4be2ff8a3c30c57880bd7b60fd5435ca371a56dbd960fb6f42d5c8b9e2ab78cc8c4dc69e6850ac2e4c5c0"} 07:58:23 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:23 INFO - Copying logs to upload dir... 07:58:23 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.309053 ========= master_lag: 5.62 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-11-17 07:58:29.570293) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-11-17 07:58:29.575611) ========= 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.ULpxVTLECD/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.3Txqw2OpSi/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1140890440b51d1ead3ce9b41acdbdd102876660897f8f462e8434bfbb9aa2270baef180591e54fe8b5609794838c8877c84d1bc37f5d32721ac55a9a40e204", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3382949580eed1e4f370359388bd4f0b6067a48d3f6a44254a13a873e4243e3967593199b3c758ca9891861df3ac470143522b24a6f02312f29008efac5c49ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d9805dacd7c0eccb650d6554efb9b1ec2ef8c7111e4be2ff8a3c30c57880bd7b60fd5435ca371a56dbd960fb6f42d5c8b9e2ab78cc8c4dc69e6850ac2e4c5c0"} build_url:https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/UwnknT1yTByY9hJZxabs0A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1140890440b51d1ead3ce9b41acdbdd102876660897f8f462e8434bfbb9aa2270baef180591e54fe8b5609794838c8877c84d1bc37f5d32721ac55a9a40e204", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3382949580eed1e4f370359388bd4f0b6067a48d3f6a44254a13a873e4243e3967593199b3c758ca9891861df3ac470143522b24a6f02312f29008efac5c49ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d9805dacd7c0eccb650d6554efb9b1ec2ef8c7111e4be2ff8a3c30c57880bd7b60fd5435ca371a56dbd960fb6f42d5c8b9e2ab78cc8c4dc69e6850ac2e4c5c0"}' ========= master_lag: 2.24 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-11-17 07:58:31.823989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:58:31.824379) ========= 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.ULpxVTLECD/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.3Txqw2OpSi/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.004646 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:58:31.860386) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 07:58:31.860701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 07:58:31.860991) ========= ========= Total master_lag: 7.96 =========