builder: cedar_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0265 starttime: 1480334921.5 results: success (0) buildid: 20161128014959 builduid: 8b229706cbbf4b79a5b6d3c83de8dc36 revision: 05c81f3630adf8eadd8d914932b6da07e7afbddc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 04:08:41.495638) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 04:08:41.496022) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 04:08:41.496293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 04:08:41.814258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 04:08:41.814690) ========= 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.Z645NA5red/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.FRgK30UvBr/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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-28 04:08:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 61.8M=0s 2016-11-28 04:08:42 (61.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.506801 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 04:08:42.347610) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 04:08:42.347916) ========= 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.Z645NA5red/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.FRgK30UvBr/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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.027705 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 04:08:42.400728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-28 04:08:42.401108) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 05c81f3630adf8eadd8d914932b6da07e7afbddc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 05c81f3630adf8eadd8d914932b6da07e7afbddc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z645NA5red/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.FRgK30UvBr/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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-28 04:08:42,499 truncating revision to first 12 chars 2016-11-28 04:08:42,500 Setting DEBUG logging. 2016-11-28 04:08:42,500 attempt 1/10 2016-11-28 04:08:42,500 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/05c81f3630ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-28 04:08:44,190 unpacking tar archive at: cedar-05c81f3630ad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.958989 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-28 04:08:44.420729) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 04:08:44.421220) ========= script_repo_revision: 05c81f3630adf8eadd8d914932b6da07e7afbddc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 04:08:44.421819) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 04:08:44.422315) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 04:08:44.447141) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-28 04:08:44.447616) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z645NA5red/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.FRgK30UvBr/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 04:08:44 INFO - MultiFileLogger online at 20161128 04:08:44 in /builds/slave/test 04:08:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 04:08:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:44 INFO - {'append_to_log': False, 04:08:44 INFO - 'base_work_dir': '/builds/slave/test', 04:08:44 INFO - 'blob_upload_branch': 'Cedar', 04:08:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:44 INFO - 'branch': 'Cedar', 04:08:44 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:44 INFO - 'config_files': ('talos/mac_config.py',), 04:08:44 INFO - 'default_actions': ('clobber', 04:08:44 INFO - 'read-buildbot-config', 04:08:44 INFO - 'download-and-extract', 04:08:44 INFO - 'populate-webroot', 04:08:44 INFO - 'create-virtualenv', 04:08:44 INFO - 'install', 04:08:44 INFO - 'run-tests'), 04:08:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:44 INFO - 'download_minidump_stackwalk': True, 04:08:44 INFO - 'download_symbols': 'ondemand', 04:08:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:44 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:44 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:44 INFO - 'installer_path': 'installer.exe', 04:08:44 INFO - 'log_level': 'info', 04:08:44 INFO - 'log_name': 'talos', 04:08:44 INFO - 'log_to_console': True, 04:08:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:08:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:08:44 INFO - 'opt_config_files': (), 04:08:44 INFO - 'pip_index': False, 04:08:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:08:44 INFO - 'cmd': ('bash', 04:08:44 INFO - '-c', 04:08:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:08:44 INFO - 'enabled': True, 04:08:44 INFO - 'halt_on_failure': False, 04:08:44 INFO - 'name': 'check_screen_resolution'},), 04:08:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:08:44 INFO - 'cmd': ('bash', 04:08:44 INFO - '-c', 04:08:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:08:44 INFO - 'enabled': True, 04:08:44 INFO - 'halt_on_failure': False, 04:08:44 INFO - 'name': 'check_screen_resolution'},), 04:08:44 INFO - 'run_cmd_checks_enabled': True, 04:08:44 INFO - 'sps_profile': False, 04:08:44 INFO - 'sps_profile_interval': 0, 04:08:44 INFO - 'suite': 'dromaeojs', 04:08:44 INFO - 'system_bits': '32', 04:08:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:44 INFO - 'title': 't-yosemite-r7-0265', 04:08:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:44 INFO - 'use_talos_json': True, 04:08:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:44 INFO - 'work_dir': 'build'} 04:08:44 INFO - [mozharness: 2016-11-28 12:08:44.651921Z] Running clobber step. 04:08:44 INFO - Running pre-action listener: _resource_record_pre_action 04:08:44 INFO - Running main action method: clobber 04:08:44 INFO - rmtree: /builds/slave/test/build 04:08:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:46 INFO - Running post-action listener: _resource_record_post_action 04:08:46 INFO - [mozharness: 2016-11-28 12:08:46.942699Z] Finished clobber step (success) 04:08:46 INFO - [mozharness: 2016-11-28 12:08:46.942848Z] Running read-buildbot-config step. 04:08:46 INFO - Running pre-action listener: _resource_record_pre_action 04:08:46 INFO - Running main action method: read_buildbot_config 04:08:46 INFO - Using buildbot properties: 04:08:46 INFO - { 04:08:46 INFO - "project": "", 04:08:46 INFO - "product": "firefox", 04:08:46 INFO - "script_repo_revision": "default", 04:08:46 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs", 04:08:46 INFO - "repository": "", 04:08:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs", 04:08:46 INFO - "buildid": "20161128014959", 04:08:46 INFO - "pgo_build": "False", 04:08:46 INFO - "basedir": "/builds/slave/test", 04:08:46 INFO - "buildnumber": 0, 04:08:46 INFO - "slavename": "t-yosemite-r7-0265", 04:08:46 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:08:46 INFO - "platform": "yosemite_r7", 04:08:46 INFO - "scheduler": "tests-cedar-macosx64-talos", 04:08:46 INFO - "branch": "cedar", 04:08:46 INFO - "repo_path": "projects/cedar", 04:08:46 INFO - "revision": "05c81f3630adf8eadd8d914932b6da07e7afbddc", 04:08:46 INFO - "stage_platform": "macosx64", 04:08:46 INFO - "builduid": "8b229706cbbf4b79a5b6d3c83de8dc36", 04:08:46 INFO - "slavebuilddir": "test" 04:08:46 INFO - } 04:08:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:08:46 INFO - Running post-action listener: _resource_record_post_action 04:08:46 INFO - [mozharness: 2016-11-28 12:08:46.946164Z] Finished read-buildbot-config step (success) 04:08:46 INFO - [mozharness: 2016-11-28 12:08:46.946277Z] Running download-and-extract step. 04:08:46 INFO - Running pre-action listener: _resource_record_pre_action 04:08:46 INFO - Running main action method: download_and_extract 04:08:46 INFO - mkdir: /builds/slave/test/build/tests 04:08:46 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')]} 04:08:46 INFO - trying https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:08:46 INFO - Downloading https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/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 04:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/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 04:08:47 INFO - Downloaded 1199 bytes. 04:08:47 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:08:47 INFO - Using the following test package requirements: 04:08:47 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:08:47 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:08:47 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:08:47 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:08:47 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:08:47 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:08:47 INFO - u'jsshell-mac.zip'], 04:08:47 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:08:47 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:08:47 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:08:47 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:08:47 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:08:47 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:08:47 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:08:47 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:08:47 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:08:47 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:08:47 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:08:47 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:08:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:08:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:08:47 INFO - Fetch https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:08:48 INFO - Http code: 200 04:08:48 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 04:08:48 INFO - x-amz-cf-id: qaQupseMWTHlnx2Nzk8NDdrzeIuljJG7Uz7BpevUAwV3dg1zkUeoMg== 04:08:48 INFO - x-amz-version-id: afVhh.uErTYTONIshw_KnjYZFx5o8NYX 04:08:48 INFO - Expected file size: 16282621 04:08:48 INFO - Obtained file size: 16282621 04:08:55 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 04:08:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:08:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:08:55 INFO - Fetch https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:08:55 INFO - Http code: 200 04:08:55 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 04:08:55 INFO - x-amz-cf-id: Tm7JPY7UKakXeq3L1NXHKS9Juc8_nhINBr2y1Kgcs-UnhSPwno1TAg== 04:08:55 INFO - x-amz-version-id: afVhh.uErTYTONIshw_KnjYZFx5o8NYX 04:08:56 INFO - Expected file size: 16282621 04:08:56 INFO - Obtained file size: 16282621 04:09:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:09:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:09:02 INFO - Fetch https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:09:03 INFO - Http code: 200 04:09:03 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 04:09:03 INFO - x-amz-cf-id: _LBViskEVvqGZlB741zjsc0vyANPbDJpN2jzeIsNS_BvYJlGZ3jmpg== 04:09:03 INFO - x-amz-version-id: HvWMi_1ia_5mgNlmeYOuLFYazUuyXlwI 04:09:03 INFO - Expected file size: 14409702 04:09:03 INFO - Obtained file size: 14409702 04:09: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')]} 04:09:03 INFO - trying https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:09:03 INFO - Downloading https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/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 04:09:06 INFO - Downloaded 107606379 bytes. 04:09:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:09:06 INFO - mkdir: /builds/slave/test/properties 04:09:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:09:06 INFO - Writing to file /builds/slave/test/properties/build_url 04:09:06 INFO - Contents: 04:09:06 INFO - build_url:https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:09:07 INFO - Running post-action listener: _resource_record_post_action 04:09:07 INFO - Running post-action listener: set_extra_try_arguments 04:09:07 INFO - [mozharness: 2016-11-28 12:09:07.194756Z] Finished download-and-extract step (success) 04:09:07 INFO - [mozharness: 2016-11-28 12:09:07.194854Z] Running populate-webroot step. 04:09:07 INFO - Running pre-action listener: _resource_record_pre_action 04:09:07 INFO - Running main action method: populate_webroot 04:09:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:09:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:09:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:09:07 INFO - '--tppagecycles', 04:09:07 INFO - '7'], 04:09:07 INFO - 'tests': ['tsvgm']}}, 04:09:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:09:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:09:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:09:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:09:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:09:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:09:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:09:07 INFO - 'talos_options': ['--disable-e10s'], 04:09:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:09:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:09:07 INFO - 'talos_options': ['--disable-e10s'], 04:09:07 INFO - 'tests': ['damp', 'tps']}, 04:09:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:09:07 INFO - 'tests': ['damp', 'tps']}, 04:09:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:09:07 INFO - 'tests': ['dromaeo_dom']}, 04:09:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:09:07 INFO - 'tests': ['basic_compositor_video']}, 04:09:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:09:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:09:07 INFO - 'tests': ['a11yr', 04:09:07 INFO - 'ts_paint', 04:09:07 INFO - 'tpaint', 04:09:07 INFO - 'sessionrestore', 04:09:07 INFO - 'sessionrestore_no_auto_restore', 04:09:07 INFO - 'tabpaint']}, 04:09:07 INFO - 'other-e10s': {'tests': ['a11yr', 04:09:07 INFO - 'ts_paint', 04:09:07 INFO - 'tpaint', 04:09:07 INFO - 'sessionrestore', 04:09:07 INFO - 'sessionrestore_no_auto_restore', 04:09:07 INFO - 'tabpaint']}, 04:09:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:09:07 INFO - 'ts_paint', 04:09:07 INFO - 'tpaint', 04:09:07 INFO - 'sessionrestore', 04:09:07 INFO - 'sessionrestore_no_auto_restore', 04:09:07 INFO - 'tabpaint']}, 04:09:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:09:07 INFO - 'ts_paint', 04:09:07 INFO - 'tpaint', 04:09:07 INFO - 'sessionrestore', 04:09:07 INFO - 'sessionrestore_no_auto_restore', 04:09:07 INFO - 'tabpaint']}, 04:09:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:09:07 INFO - 'tests': ['a11yr', 04:09:07 INFO - 'ts_paint', 04:09:07 INFO - 'tpaint', 04:09:07 INFO - 'sessionrestore', 04:09:07 INFO - 'sessionrestore_no_auto_restore', 04:09:07 INFO - 'tabpaint']}, 04:09:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:09:07 INFO - 'tests': ['a11yr', 04:09:07 INFO - 'ts_paint', 04:09:07 INFO - 'tpaint', 04:09:07 INFO - 'sessionrestore', 04:09:07 INFO - 'sessionrestore_no_auto_restore', 04:09:07 INFO - 'tabpaint']}, 04:09:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:09:07 INFO - 'tests': ['tsvgx', 04:09:07 INFO - 'tsvgr_opacity', 04:09:07 INFO - 'tart', 04:09:07 INFO - 'tscrollx', 04:09:07 INFO - 'cart', 04:09:07 INFO - 'tsvg_static']}, 04:09:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:09:07 INFO - 'tsvgr_opacity', 04:09:07 INFO - 'tart', 04:09:07 INFO - 'tscrollx', 04:09:07 INFO - 'cart', 04:09:07 INFO - 'tsvg_static']}, 04:09:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:09:07 INFO - 'talos_options': ['--disable-e10s'], 04:09:07 INFO - 'tests': ['tp5o']}, 04:09:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:09:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:09:07 INFO - 'talos_options': ['--disable-e10s', 04:09:07 INFO - '--xperf_path', 04:09:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:07 INFO - 'tests': ['tp5n']}, 04:09:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:09:07 INFO - 'talos_options': ['--xperf_path', 04:09:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:07 INFO - 'tests': ['tp5n']}}, 04:09:07 INFO - 'talos.zip': {'path': '', 04:09:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:09:07 INFO - Running post-action listener: _resource_record_post_action 04:09:07 INFO - [mozharness: 2016-11-28 12:09:07.213255Z] Finished populate-webroot step (success) 04:09:07 INFO - [mozharness: 2016-11-28 12:09:07.213386Z] Running create-virtualenv step. 04:09:07 INFO - Running pre-action listener: _resource_record_pre_action 04:09:07 INFO - Running main action method: create_virtualenv 04:09:07 INFO - Creating virtualenv /builds/slave/test/build/venv 04:09:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:09:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:09:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:07 INFO - Using real prefix '/tools/python27' 04:09:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:09:08 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:10 INFO - Installing pip.................done. 04:09:10 INFO - Return code: 0 04:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:09:11 INFO - Reading from file tmpfile_stdout 04:09:11 INFO - Output received: 04:09:11 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) 04:09:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec283f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe971d99e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3ed30>, '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 0x10e8a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea36b20>, '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.Z645NA5red/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.FRgK30UvBr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 04:09:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:09:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z645NA5red/Render', 04:09:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:11 INFO - 'HOME': '/Users/cltbld', 04:09:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:11 INFO - 'LOGNAME': 'cltbld', 04:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:11 INFO - 'MOZ_NO_REMOTE': '1', 04:09:11 INFO - 'NO_EM_RESTART': '1', 04:09:11 INFO - 'PAGER': '/bin/cat', 04:09:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:11 INFO - 'PWD': '/builds/slave/test', 04:09:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:11 INFO - 'SHELL': '/bin/bash', 04:09:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FRgK30UvBr/Listeners', 04:09:11 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 04:09:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:11 INFO - 'USER': 'cltbld', 04:09:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:11 INFO - 'XPC_FLAGS': '0x0', 04:09:11 INFO - 'XPC_SERVICE_NAME': '0', 04:09:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:09:11 INFO - Cleaning up... 04:09:11 INFO - Return code: 0 04:09:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec283f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe971d99e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3ed30>, '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 0x10e8a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea36b20>, '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.Z645NA5red/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.FRgK30UvBr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 04:09:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:09:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z645NA5red/Render', 04:09:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:11 INFO - 'HOME': '/Users/cltbld', 04:09:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:11 INFO - 'LOGNAME': 'cltbld', 04:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:11 INFO - 'MOZ_NO_REMOTE': '1', 04:09:11 INFO - 'NO_EM_RESTART': '1', 04:09:11 INFO - 'PAGER': '/bin/cat', 04:09:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:11 INFO - 'PWD': '/builds/slave/test', 04:09:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:11 INFO - 'SHELL': '/bin/bash', 04:09:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FRgK30UvBr/Listeners', 04:09:11 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 04:09:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:11 INFO - 'USER': 'cltbld', 04:09:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:11 INFO - 'XPC_FLAGS': '0x0', 04:09:11 INFO - 'XPC_SERVICE_NAME': '0', 04:09:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:11 INFO - Downloading/unpacking psutil>=3.1.1 04:09:11 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 04:09:11 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 04:09:11 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 04:09:11 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 04:09:11 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 04:09:11 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 04:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:15 INFO - Installing collected packages: psutil 04:09:15 INFO - Running setup.py install for psutil 04:09:15 INFO - building 'psutil._psutil_osx' extension 04:09:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:09:16 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 04:09:16 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 04:09:16 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 04:09:16 INFO - building 'psutil._psutil_posix' extension 04:09:16 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 04:09:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:09:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:09:16 INFO - ^ 04:09:16 INFO - 1 warning generated. 04:09:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:09:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:16 INFO - Successfully installed psutil 04:09:16 INFO - Cleaning up... 04:09:16 INFO - Return code: 0 04:09:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec283f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe971d99e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3ed30>, '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 0x10e8a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea36b20>, '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.Z645NA5red/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.FRgK30UvBr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 04:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:09:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z645NA5red/Render', 04:09:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:16 INFO - 'HOME': '/Users/cltbld', 04:09:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:16 INFO - 'LOGNAME': 'cltbld', 04:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:16 INFO - 'MOZ_NO_REMOTE': '1', 04:09:16 INFO - 'NO_EM_RESTART': '1', 04:09:16 INFO - 'PAGER': '/bin/cat', 04:09:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:16 INFO - 'PWD': '/builds/slave/test', 04:09:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:16 INFO - 'SHELL': '/bin/bash', 04:09:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FRgK30UvBr/Listeners', 04:09:16 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 04:09:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:16 INFO - 'USER': 'cltbld', 04:09:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:16 INFO - 'XPC_FLAGS': '0x0', 04:09:16 INFO - 'XPC_SERVICE_NAME': '0', 04:09:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:09:19 INFO - Installing collected packages: mozsystemmonitor 04:09:19 INFO - Running setup.py install for mozsystemmonitor 04:09:19 INFO - Successfully installed mozsystemmonitor 04:09:19 INFO - Cleaning up... 04:09:19 INFO - Return code: 0 04:09:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ec283f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe971d99e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3ed30>, '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 0x10e8a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea36b20>, '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.Z645NA5red/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.FRgK30UvBr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 04:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:09:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z645NA5red/Render', 04:09:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:19 INFO - 'HOME': '/Users/cltbld', 04:09:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:19 INFO - 'LOGNAME': 'cltbld', 04:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:19 INFO - 'MOZ_NO_REMOTE': '1', 04:09:19 INFO - 'NO_EM_RESTART': '1', 04:09:19 INFO - 'PAGER': '/bin/cat', 04:09:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:19 INFO - 'PWD': '/builds/slave/test', 04:09:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:19 INFO - 'SHELL': '/bin/bash', 04:09:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FRgK30UvBr/Listeners', 04:09:19 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 04:09:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:20 INFO - 'USER': 'cltbld', 04:09:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:20 INFO - 'XPC_FLAGS': '0x0', 04:09:20 INFO - 'XPC_SERVICE_NAME': '0', 04:09:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:20 INFO - Downloading/unpacking jsonschema==2.5.1 04:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:09:22 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 04:09:22 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 04:09:22 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 04:09:22 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 04:09:22 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 04:09:22 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 04:09:23 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:23 INFO - warning: no files found matching '*.txt' 04:09:23 INFO - no previously-included directories found matching 'build' 04:09:23 INFO - no previously-included directories found matching 'dist' 04:09:23 INFO - no previously-included directories found matching '.git*' 04:09:23 INFO - Installing collected packages: jsonschema, functools32 04:09:23 INFO - Running setup.py install for functools32 04:09:23 INFO - warning: no files found matching '*.txt' 04:09:23 INFO - no previously-included directories found matching 'build' 04:09:23 INFO - no previously-included directories found matching 'dist' 04:09:23 INFO - no previously-included directories found matching '.git*' 04:09:23 INFO - Successfully installed jsonschema functools32 04:09:23 INFO - Cleaning up... 04:09:23 INFO - Return code: 0 04:09:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:09:23 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')]} 04:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:23 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')]} 04:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:23 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 0x10ec283f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe971d99e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3ed30>, '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 0x10e8a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea36b20>, '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.Z645NA5red/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.FRgK30UvBr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 04:09:23 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 04:09:23 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 04:09:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z645NA5red/Render', 04:09:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:23 INFO - 'HOME': '/Users/cltbld', 04:09:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:23 INFO - 'LOGNAME': 'cltbld', 04:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:23 INFO - 'MOZ_NO_REMOTE': '1', 04:09:23 INFO - 'NO_EM_RESTART': '1', 04:09:23 INFO - 'PAGER': '/bin/cat', 04:09:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:23 INFO - 'PWD': '/builds/slave/test', 04:09:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:23 INFO - 'SHELL': '/bin/bash', 04:09:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FRgK30UvBr/Listeners', 04:09:23 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 04:09:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:23 INFO - 'USER': 'cltbld', 04:09:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:23 INFO - 'XPC_FLAGS': '0x0', 04:09:23 INFO - 'XPC_SERVICE_NAME': '0', 04:09:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:09:23 INFO - Cleaning up... 04:09:23 INFO - Return code: 0 04:09:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09:23 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')]} 04:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:23 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')]} 04:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:23 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 0x10ec283f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe971d99e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3ed30>, '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 0x10e8a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea36b20>, '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.Z645NA5red/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.FRgK30UvBr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 04:09:23 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 04:09:23 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 04:09:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z645NA5red/Render', 04:09:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:23 INFO - 'HOME': '/Users/cltbld', 04:09:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:23 INFO - 'LOGNAME': 'cltbld', 04:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:23 INFO - 'MOZ_NO_REMOTE': '1', 04:09:23 INFO - 'NO_EM_RESTART': '1', 04:09:23 INFO - 'PAGER': '/bin/cat', 04:09:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:23 INFO - 'PWD': '/builds/slave/test', 04:09:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:23 INFO - 'SHELL': '/bin/bash', 04:09:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FRgK30UvBr/Listeners', 04:09:23 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 04:09:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:23 INFO - 'USER': 'cltbld', 04:09:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:23 INFO - 'XPC_FLAGS': '0x0', 04:09:23 INFO - 'XPC_SERVICE_NAME': '0', 04:09:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:24 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:26 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:27 INFO - Downloading docopt-0.6.1.tar.gz 04:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:28 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:28 INFO - Running setup.py install for blobuploader 04:09:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:28 INFO - Running setup.py install for requests 04:09:28 INFO - Running setup.py install for docopt 04:09:28 INFO - Successfully installed blobuploader requests docopt 04:09:28 INFO - Cleaning up... 04:09:28 INFO - Return code: 0 04:09:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:28 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 0x10ec283f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe971d99e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3ed30>, '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 0x10e8a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea36b20>, '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.Z645NA5red/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.FRgK30UvBr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 04:09:28 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 04:09:28 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 04:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z645NA5red/Render', 04:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:28 INFO - 'HOME': '/Users/cltbld', 04:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:28 INFO - 'LOGNAME': 'cltbld', 04:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:28 INFO - 'MOZ_NO_REMOTE': '1', 04:09:28 INFO - 'NO_EM_RESTART': '1', 04:09:28 INFO - 'PAGER': '/bin/cat', 04:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:28 INFO - 'PWD': '/builds/slave/test', 04:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:28 INFO - 'SHELL': '/bin/bash', 04:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FRgK30UvBr/Listeners', 04:09:28 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 04:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:28 INFO - 'USER': 'cltbld', 04:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:28 INFO - 'XPC_FLAGS': '0x0', 04:09:28 INFO - 'XPC_SERVICE_NAME': '0', 04:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:29 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-BQ2VZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:29 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-HhLrqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:29 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-vviqB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:29 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-RC26Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:29 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-92Oddc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:29 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-jEPhgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:29 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-8aSu39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:29 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-W3_VHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:30 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-RKa_y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:30 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-EIoAqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:30 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-t4Pk3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:30 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-bATTZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:30 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-8m8H9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:30 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-JRLwzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:30 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-Ia2woH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:30 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-j2CCMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:30 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-FgWCLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:30 INFO - Running setup.py install for manifestparser 04:09:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:31 INFO - Running setup.py install for mozcrash 04:09:31 INFO - Running setup.py install for mozdebug 04:09:31 INFO - Running setup.py install for mozdevice 04:09:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:09:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:31 INFO - Running setup.py install for mozfile 04:09:31 INFO - Running setup.py install for mozhttpd 04:09:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:31 INFO - Running setup.py install for mozinfo 04:09:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:32 INFO - Running setup.py install for mozInstall 04:09:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:32 INFO - Running setup.py install for mozleak 04:09:32 INFO - Running setup.py install for mozlog 04:09:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:32 INFO - Running setup.py install for moznetwork 04:09:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:32 INFO - Running setup.py install for mozprocess 04:09:32 INFO - Running setup.py install for mozprofile 04:09:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:32 INFO - Running setup.py install for mozrunner 04:09:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:33 INFO - Running setup.py install for mozscreenshot 04:09:33 INFO - Running setup.py install for moztest 04:09:33 INFO - Running setup.py install for mozversion 04:09:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:33 INFO - Cleaning up... 04:09:33 INFO - Return code: 0 04:09:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec283f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe971d99e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3ed30>, '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 0x10e8a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea36b20>, '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.Z645NA5red/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.FRgK30UvBr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 04:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:09:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z645NA5red/Render', 04:09:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:33 INFO - 'HOME': '/Users/cltbld', 04:09:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:33 INFO - 'LOGNAME': 'cltbld', 04:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:33 INFO - 'MOZ_NO_REMOTE': '1', 04:09:33 INFO - 'NO_EM_RESTART': '1', 04:09:33 INFO - 'PAGER': '/bin/cat', 04:09:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:33 INFO - 'PWD': '/builds/slave/test', 04:09:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:33 INFO - 'SHELL': '/bin/bash', 04:09:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FRgK30UvBr/Listeners', 04:09:33 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 04:09:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:33 INFO - 'USER': 'cltbld', 04:09:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:33 INFO - 'XPC_FLAGS': '0x0', 04:09:33 INFO - 'XPC_SERVICE_NAME': '0', 04:09:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:33 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-_LSW7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:33 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)) 04:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:33 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-oq8aqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:34 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)) 04:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:34 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-rN5nHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:34 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-AZmFH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:34 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-zVYdla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:34 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-0qiseH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:34 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-6pSuzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:34 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-FMZW9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:34 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-c2qZyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:34 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-AH9rEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:34 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)) 04:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:34 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-KNUZ91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:34 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)) 04:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:34 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-4GUm2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:35 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)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:35 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-8QsJU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:35 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-4EXfB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:35 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)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:35 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-yMJBzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:35 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-CHigUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:35 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-KHQjex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:09:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:38 INFO - Downloading blessings-1.6.tar.gz 04:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:38 INFO - Installing collected packages: blessings 04:09:38 INFO - Running setup.py install for blessings 04:09:38 INFO - Successfully installed blessings 04:09:38 INFO - Cleaning up... 04:09:38 INFO - Return code: 0 04:09:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:38 INFO - Reading from file tmpfile_stdout 04:09:38 INFO - Current package versions: 04:09:38 INFO - blessings == 1.6 04:09:38 INFO - blobuploader == 1.2.4 04:09:38 INFO - docopt == 0.6.1 04:09:38 INFO - functools32 == 3.2.3-2 04:09:38 INFO - jsonschema == 2.5.1 04:09:38 INFO - manifestparser == 1.1 04:09:38 INFO - mozInstall == 1.12 04:09:38 INFO - mozcrash == 1.0 04:09:38 INFO - mozdebug == 0.1 04:09:38 INFO - mozdevice == 0.49 04:09:38 INFO - mozfile == 1.2 04:09:38 INFO - mozhttpd == 0.7 04:09:38 INFO - mozinfo == 0.9 04:09:38 INFO - mozleak == 0.1 04:09:38 INFO - mozlog == 3.4 04:09:38 INFO - moznetwork == 0.27 04:09:38 INFO - mozprocess == 0.23 04:09:38 INFO - mozprofile == 0.28 04:09:38 INFO - mozrunner == 6.13 04:09:38 INFO - mozscreenshot == 0.1 04:09:38 INFO - mozsystemmonitor == 0.3 04:09:38 INFO - moztest == 0.7 04:09:38 INFO - mozversion == 1.4 04:09:38 INFO - psutil == 3.1.1 04:09:38 INFO - requests == 1.2.3 04:09:38 INFO - wsgiref == 0.1.2 04:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:38 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 0x10ec283f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe971d99e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3ed30>, '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 0x10e8a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea36b20>, '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.Z645NA5red/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.FRgK30UvBr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 04:09:38 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 04:09:38 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 04:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z645NA5red/Render', 04:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:38 INFO - 'HOME': '/Users/cltbld', 04:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:38 INFO - 'LOGNAME': 'cltbld', 04:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:38 INFO - 'MOZ_NO_REMOTE': '1', 04:09:38 INFO - 'NO_EM_RESTART': '1', 04:09:38 INFO - 'PAGER': '/bin/cat', 04:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:38 INFO - 'PWD': '/builds/slave/test', 04:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:38 INFO - 'SHELL': '/bin/bash', 04:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FRgK30UvBr/Listeners', 04:09:38 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 04:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:38 INFO - 'USER': 'cltbld', 04:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:38 INFO - 'XPC_FLAGS': '0x0', 04:09:38 INFO - 'XPC_SERVICE_NAME': '0', 04:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:09:39 INFO - Cleaning up... 04:09:39 INFO - Return code: 0 04:09:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec283f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe971d99e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3ed30>, '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 0x10e8a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea36b20>, '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.Z645NA5red/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.FRgK30UvBr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 04:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z645NA5red/Render', 04:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:39 INFO - 'HOME': '/Users/cltbld', 04:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:39 INFO - 'LOGNAME': 'cltbld', 04:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:39 INFO - 'MOZ_NO_REMOTE': '1', 04:09:39 INFO - 'NO_EM_RESTART': '1', 04:09:39 INFO - 'PAGER': '/bin/cat', 04:09:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:39 INFO - 'PWD': '/builds/slave/test', 04:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:39 INFO - 'SHELL': '/bin/bash', 04:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FRgK30UvBr/Listeners', 04:09:39 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 04:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:39 INFO - 'USER': 'cltbld', 04:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:39 INFO - 'XPC_FLAGS': '0x0', 04:09:39 INFO - 'XPC_SERVICE_NAME': '0', 04:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:09:39 INFO - Cleaning up... 04:09:39 INFO - Return code: 0 04:09:39 INFO - Running post-action listener: _resource_record_post_action 04:09:39 INFO - Running post-action listener: _start_resource_monitoring 04:09:39 INFO - Starting resource monitoring. 04:09:39 INFO - [mozharness: 2016-11-28 12:09:39.352086Z] Finished create-virtualenv step (success) 04:09:39 INFO - [mozharness: 2016-11-28 12:09:39.353103Z] Running install step. 04:09:39 INFO - Running pre-action listener: _resource_record_pre_action 04:09:39 INFO - Running main action method: install 04:09:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:39 INFO - Reading from file tmpfile_stdout 04:09:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:39 INFO - Reading from file tmpfile_stdout 04:09:39 INFO - Output received: 04:09:39 INFO - Usage: mozinstall [options] installer 04:09:39 INFO - Options: 04:09:39 INFO - -h, --help show this help message and exit 04:09:39 INFO - -d DEST, --destination=DEST 04:09:39 INFO - Directory to install application into. [default: 04:09:39 INFO - "/builds/slave/test"] 04:09:39 INFO - --app=APP Application being installed. [default: firefox] 04:09:39 INFO - mkdir: /builds/slave/test/build/application 04:09:39 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'] 04:09:39 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 04:10:12 INFO - Reading from file tmpfile_stdout 04:10:12 INFO - Output received: 04:10:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:10:12 INFO - Running post-action listener: _resource_record_post_action 04:10:12 INFO - [mozharness: 2016-11-28 12:10:12.624381Z] Finished install step (success) 04:10:12 INFO - [mozharness: 2016-11-28 12:10:12.624523Z] Running run-tests step. 04:10:12 INFO - Running pre-action listener: _resource_record_pre_action 04:10:12 INFO - Running main action method: run_tests 04:10:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:10:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:10:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:10:12 INFO - 2016-11-28 04:10:12.639 screenresolution[1633:8049] starting screenresolution argv=screenresolution get 04:10:12 INFO - 2016-11-28 04:10:12.641 screenresolution[1633:8049] Display 0: 1600x1200x32@60 04:10:12 INFO - 2016-11-28 04:10:12.647 screenresolution[1634:8051] starting screenresolution argv=screenresolution list 04:10:12 INFO - Available Modes on Display 0 04:10:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:10:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:10:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:10:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:10:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:10:12 INFO - Intel Iris: 04:10:12 INFO - Chipset Model: Intel Iris 04:10:12 INFO - Type: GPU 04:10:12 INFO - Bus: Built-In 04:10:12 INFO - VRAM (Dynamic, Max): 1536 MB 04:10:12 INFO - Vendor: Intel (0x8086) 04:10:12 INFO - Device ID: 0x0a2e 04:10:12 INFO - Revision ID: 0x0009 04:10:12 INFO - Displays: 04:10:12 INFO - Display: 04:10:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:10:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:10:12 INFO - Display Serial Number: 1600x1200 60 04:10:12 INFO - Main Display: Yes 04:10:12 INFO - Mirror: Off 04:10:12 INFO - Online: Yes 04:10:12 INFO - Rotation: Supported 04:10:12 INFO - Return code: 0 04:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:10:12 INFO - Python 2.7.3 04:10:12 INFO - Return code: 0 04:10:12 INFO - grabbing minidump binary from tooltool 04:10:12 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')]} 04:10:12 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 0x10ea3ed30>, '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 0x10e8a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea36b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:10:12 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 04:10:12 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 04:10:12 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 04:10:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:10:13 INFO - Return code: 0 04:10:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:10:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:10:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:10:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:10:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0265', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0265 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:10:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z645NA5red/Render', 04:10:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:10:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:10:13 INFO - 'HOME': '/Users/cltbld', 04:10:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:10:13 INFO - 'LOGNAME': 'cltbld', 04:10:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:13 INFO - 'MOZ_NO_REMOTE': '1', 04:10:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:13 INFO - 'NO_EM_RESTART': '1', 04:10:13 INFO - 'PAGER': '/bin/cat', 04:10:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:13 INFO - 'PWD': '/builds/slave/test', 04:10:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:10:13 INFO - 'SHELL': '/bin/bash', 04:10:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FRgK30UvBr/Listeners', 04:10:13 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 04:10:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:10:13 INFO - 'USER': 'cltbld', 04:10:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:10:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:13 INFO - 'XPC_FLAGS': '0x0', 04:10:13 INFO - 'XPC_SERVICE_NAME': '0', 04:10:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:10:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0265', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:10:13 INFO - mozversion application_buildid: 20161128014959 04:10:13 INFO - mozversion application_changeset: 05c81f3630adf8eadd8d914932b6da07e7afbddc 04:10:13 INFO - mozversion application_display_name: Nightly 04:10:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:13 INFO - mozversion application_name: Firefox 04:10:13 INFO - mozversion application_remotingname: firefox 04:10:13 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 04:10:13 INFO - mozversion application_vendor: Mozilla 04:10:13 INFO - mozversion application_version: 53.0a1 04:10:13 INFO - mozversion platform_buildid: 20161128014959 04:10:13 INFO - mozversion platform_changeset: 05c81f3630adf8eadd8d914932b6da07e7afbddc 04:10:13 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 04:10:13 INFO - mozversion platform_version: 53.0a1 04:10:13 INFO - using testdate: 1480335013 04:10:13 INFO - actual date: 1480335013 04:10:13 INFO - starting webserver on 'localhost:49241' 04:10:13 INFO - SUITE-START | Running 2 tests 04:10:13 INFO - TEST-START | dromaeo_css 04:10:13 INFO - operating with platform_type : mac_ 04:10:13 INFO - Initialising browser for dromaeo_css test... 04:10:13 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpoSQi2F/profile http://localhost:49241/getInfo.html) 04:10:15 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 04:10:15 INFO - PROCESS | 1644 | colorDepth:24 04:10:15 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 04:10:15 INFO - PROCESS | 1644 | __metrics 04:10:16 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:10:16 INFO - PROCESS | 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:10:16 INFO - TEST-INFO | 1644: exit 0 04:10:16 INFO - Browser initialized. 04:10:16 INFO - Running cycle 1/1 for dromaeo_css test... 04:10:16 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpoSQi2F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:29 INFO - PROCESS | 1647 | RSS: Main: 245329920 04:10:29 INFO - PROCESS | 1647 | 04:11:20 INFO - PROCESS | 1647 | 1480335080435 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] 04:13:33 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:13:35 INFO - PROCESS | 1647 | RSS: Main: 401534976 04:13:35 INFO - PROCESS | 1647 | 04:16:38 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:16:39 INFO - PROCESS | 1647 | RSS: Main: 375123968 04:16:39 INFO - PROCESS | 1647 | 04:19:41 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 04:19:42 INFO - PROCESS | 1647 | RSS: Main: 343281664 04:19:42 INFO - PROCESS | 1647 | 04:22:44 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 04:22:45 INFO - PROCESS | 1647 | RSS: Main: 345051136 04:22:45 INFO - PROCESS | 1647 | 04:25:48 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 04:25:49 INFO - PROCESS | 1647 | RSS: Main: 330932224 04:25:49 INFO - PROCESS | 1647 | 04:28:53 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 04:28:53 INFO - PROCESS | 1647 | RSS: Main: 411893760 04:28:53 INFO - PROCESS | 1647 | 04:28:53 INFO - PROCESS | 1647 | __start_tp_report 04:28:53 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 04:28:53 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 04:28:53 INFO - PROCESS | 1647 | |i|pagename|runs| 04:28:53 INFO - PROCESS | 1647 | |0;dojo.html;3293.720033797128;3297.0768184908225;3298.901032969012;3333.050080726993;3356.0770788033287;5532.502074813266;5587.189857470669;5593.105103183491;5668.801591944282;5681.602287839853;5591.4688104630095;5606.383297837235;5617.4382561743805;5624.690642014698;5631.8592035199035;5110.7444627768555;5143.099957507421;5153.896922061556;5161.096808058574;5188.16989281715;5236.423993360727;5237.79048838046;5241.816536421226;5244.344456942882;5257.789688412459;5128.179491281396;5148.382194136709;5191.87020324493;5212.270282160501;5222.895542089156;5204.271402003704;5227.503387178212;5241.056609810233;5248.21276808478;5280.471952804727;5008.29883816266;5105.438401775802;5175.637705360627;5184.8963020739375;5195.68825870449;5561.443855614447;5585.720713964285;5626.156076588503;5647.124695672177;5662.546996240291;6164.599301045462;6174.166487524171;6179.227596550431;6181.907271390933;6193.1329613854095;6063.120847477091;6257.217847769029;6263.997760358321;6284.340144284875;6289.276733175698;5493.2034854945805;5515.172724091419;5520.91718624221;5637.605367624268;5702.914456283159;6107.044717083349;6118.324106893939;6126.070442333212;6127.26157773244;6131.113028989343;5605.635633683797;5741.5119714824705;5768.990426675315;5771.6248443851855;5812;5904.232449781587;5994.820155395345;6034.818955431344;6036.63780173191;6113.385090541919;6132.908006379907;6170.382961703884;6173.074038894202;6179.3820617937845;6203.193584833943;6157.8460538486;6177.042558403455;6178.598391104653;6179.721912513858;6186.072089186568;4771.618270538349;4829;4872.585830204473;4909.26361045846;4951.72765497901;4326.091520780671;4347.7173983690955;4369.235383807821;4391.626711729475;4452.243118669834;5666.801661941812;5725.541956643458;5729.197912292282;5750.02249617566;5752.683602401824;6239.282482514569;6242.500599951993;6248.375162483715;6261.624302541862;6268.623882567061;5506.256655351476;5603.635763675348;5615.354234263031;5678.3186017678145;5723.971380143073;5411.918821217685;5425.7829686812875;5428.294321738228;5439.456054394529;5442.428545002796;6294.937050629526;6297.2128483939505;6303.810885673437;6311.179546658905;6321.715522801485;6016.729247183975;6188.071789231652;6199.473044791243;6230.7507699691505;6248.906266406098;6256.280527739368;6281.434670879643;6300.71646775887;6305.96847015762;6339.778107766206;6112.169143789106;6115.602485838406;6116.518381401779;6122.672617327995;6128.503123582109;6099.847503812262;6167.6916154193;6209;6214.098955651315;6218.844528886814;5844.970775146097;5877.647341159544;5896.55775816824;6030.517558595389;6067.7431588192485;5929.584929055098;5972.611780234271;5983.431574000463;6038.064100064497;6083.270007599116;5774.855628609318;5790.652560846363;5854.2389489366105;5857.736401861841;5874.823755287348;5828.795992140254;5949;5971.701414929149;6059.121427392915;6063.423974722395;5721.22763426932;5733.197352370588;5737.942620573908;5741.196232527366;5849.1226316052935 04:28:53 INFO - PROCESS | 1647 | |1;ext.html;449.18697158143743;450.25482825923086;481.5906479492432;513.6327525819039;516.3133033066023;25089.12188073418;38003.80998095009;38847.223055538874;38891.99999999996;39041.41437878434;39725;40152.996175095635;40420.797896010554;40850.18299634005;40902.38646420306;8388.706395276167;9207.125323094311;9386.671466498674;9395.953020234923;9405.717828465156;8534.61594228258;10882;11148.21962462628;11176.385298808604;11355.545778168864;11112.722181945435;11197.776044479106;11212.831807522894;11221.270617409842;11241.66275011751;11091.057260132899;11141.610043648514;11166.609168679099;11183.384913829736;11185.217034807567;11043.282186657922;11136.777264454746;11137.610183643534;11141.498632561474;11152.16358773087;37519.62480375189;37801.62198378008;37852.81073594614;37854.62145378539;37863.432048519295;3225.209823593235;3445.620981692012;3587.964120358789;3773.735838491307;3838.251540949516;22484.550308993894;29306.413871722445;29543.556846647316;29635.11094667142;29851;3116.2209447638093;3208.0696597986557;3217.9034628961167;3263.379957808009;3279.7868138570916;375054;494977;496773;497031;499571;54838.72580637151;55343;55485.89028219494;55549.500272487836;55606;57600.423995759505;57852.710736446046;57856.71071644615;57926.13110803341;57966.13050804241;15250;15473.84526154724;15503.689926201412;15513.146776927377;15533.45632902843;10967;11795.587154449553;12145.089118316162;12229.388530573437;12230.205036672587;12875.420606072748;13303.66740831487;14309.21299328526;14413.78379324311;14606;6311.274203466568;6439.098526206335;6467.611943283324;6467.611943283418;6490.837729056811;891.5007595746403;934.2712684106408;973.2846357926918;1008.1430783833829;1094.195766111907;23806;28903.988360407704;29330.413391732047;29594.852025740165;29681.406371872872;1042.1089968077335;1047.0471870597719;1062.1131355318396;1095;1118.2898859224288;14848.851511484963;14852.851471485363;14885.255737213096;15214.087154770748;15224.695506090038;570673;652899;655146;658199.1431156732;661625;55284.44715552873;55362.40144390602;55407.89184216293;55440.44559554433;55555.722221388634;1200.3938011304235;1252.8872401483727;1329.1427029566069;1358.7690092684268;1379.8137251471123;23971.04115835347;28493.71778270024;29622.851885741296;29763.55354669725;29838.403231935674;45716.54283457123;46335.6099317021;46373;46411.303830441895;46438.839029024544;522106;523544;523889;524458;524484.377578125;24214.03143874225;24852.502949941263;25785.355366115997;25798.356295866924;33720;44346.778266108464;44759.328610070224;45052.87367815831;45301.09397812091;45955.54044459513;36748.81625591855;37201.0699732498;37437.4384384229;37861;38038.23923521459;36772.63227367692;37090.814545927096;37603.623963760016;37848.62151378451;38082.428763568016;36078.8196059018;36582.26835463329;36582.8170859144;36630.450543242405;37139.257214856094;30805.22986925345;31837.522437163;32872.849450269125;33077.17307067246;33138.83430582831;20129.295474658316;20832.687509687064;24064.518709625358;24725.381865453506;24809 04:28:53 INFO - PROCESS | 1647 | |2;jquery.html;348.5434081353429;357.1963083063107;361.392859995208;369.4163222109068;396.90275882408815;14531;14742.33659485323;15544.76682849758;19416.90291548544;19926;15517.301721422535;18252.543686407815;20194.798052019476;20466.2836800712;20471.692924606104;5164.1995490699;5450.373207081177;5451.945480545183;5458.153986132156;5468.152436372368;4225.598568136037;4668.996165824347;5385.919211211835;5389.946100539003;5429.619926605139;5409.729513524328;5425.701586412765;5432.185172224158;5435.0488664483755;5463.863403414926;5328.5470734987375;5417;5828.0966450200285;5896.734646940855;5902.881942361171;5193.272941788153;5195.480451954812;5208.947910520884;5220.190870415054;5242.580593552507;12761.298128602923;12958.22250664963;13115.344232788322;13117.409716562777;15870.841291587052;2124.702541644171;2127.319257837493;2143.3141394753684;2207.4812419081504;2635.393859412327;9792.363496372713;10310.381377117397;10340.37957722539;10937.83593246102;11571.190016698834;1778.7509748635202;1783.6967715488267;1838.834504894566;1851.9722204166949;1927.816857398545;78727.6063619684;96390.51804741002;108297;119026;119351.4032429841;10972.396518191417;10978.286411383235;11334.263272887236;11384;11615.941920290345;13903.235322057384;14262.928685356506;14339.354729037219;14346.354414051393;14416.13503189812;7953.812701507132;8219.630116644765;8242.505449673039;8331.458455200393;8348.373871959628;8085.878711819328;8093.352531797442;8095.190480951857;8225.79435514105;8256.174382561696;4342.505230744915;4412.404325416028;4472.105578884236;4497.865064048084;4507.706999045052;1663.0853030833234;1824.9635007300046;1884.396992962239;1885.9151338189815;1896.2035944903173;670.3229737964572;764.8869102751858;815.4862436664981;929.5770424456856;947.7346343023964;19609.705854412194;19931.63917372584;20345.084471198832;20401.795982040287;20565.177392904414;758.9772306830804;892.7634176943116;909.4725059465494;922.796984663373;978.9720793167146;10155.847662285072;10660.786784264272;10722.088622467178;10744.623938162127;10765.46172691378;531384;558837;560609.9695015233;560632.7011280525;564290.5709429025;97561.02438975661;110215;124257;124792.16921512714;127055;934.2666007184328;957.4973139102027;976.1897624971399;977.5112443778111;985.6402413119304;14849.331780069706;15100.622484437978;15920.805939554812;17907.283708651506;18490.630187396448;41782.37326440045;50413;51446.42455447494;52748.20877686914;56897.43102569087;76806.61596691981;80014;80642;83078.58460707658;85909;11351.716207094889;11819.645410637695;11974;12149.75700486003;12165.08761842883;13181.35233095863;13322.933385333012;13609.387577559231;13655.180689158682;13673.86326136726;11100.777984440105;11440.370779607201;11899.167058305835;11909.880901190878;12012.579559715368;10589.78217504966;11212.103031757277;11357.602483913024;11590.94204528972;11916.761664766484;9894.406335619886;10014.749631259278;11726.648200553997;11769.234999724991;11816.172867899164;11837.526498939946;11843.763124737628;11978.580749674069;12008.39958002114;12167.87832121703;11519.481623326803;11569.6529104127;11653.475593598478;11707.063434925016;11851.822222666839 04:28:53 INFO - PROCESS | 1647 | |3;mootools.html;1424.4871846135393;1475.977860332095;1611.4440518021286;1781.2963879267697;1845.2711179084263;7372.410207183426;7630.8855367169535;7877.566733829644;8220.630071646776;8240.011198656162;7508.849823003537;7861.724839630614;8044.235797599234;8045.678172873078;8152.2662960333555;2265.762094980032;2295.701558797354;2296.575133600281;2306.1006207579057;2311.526137141882;2050.128695304497;2246.359787460574;2281.9201327953524;2293.4381076636246;2295.8392912496133;2072.3472106286545;2208.4147700859285;2276.4195130241847;2281;2284;2223.5108276179217;2250.144944920936;2250.7411647660565;2251.4821591034074;2251.6960210371553;2230.631945728969;2278.8063014643776;2282.7488976212603;2284.7829456201634;2287.176616418088;8107.432479726422;8176.877346839802;8184.590770461453;8187.345012398994;8203.9745031871;4979.203327467588;5136.178211486182;5159.509846564571;5159.948400515985;5166.328377310925;3148.511980643004;3223.1458663454205;3488.3372159289906;3490.371733088043;3500.334936362083;1031.742064483879;1046.4832078850302;1058.544825724938;1070.8768491623484;1073.2165519170971;10466.424346660931;10469.581216751321;10619.946900265526;10634.255602107778;10634.680959571226;4371.322445021026;4466.665000125004;4545.999880026389;4553.567411095941;4628.213203755369;9132.680356187502;9140.771480713036;9149.268058555299;9157.267418606496;9162.22121119699;5110.4634013428795;5113.437521872591;5132.050570644443;5136.280920671109;5136.512031357015;4665.790039448233;4680.882977925579;4699.78850951708;4721.952780472151;4752.382190315306;3636.7636103653176;3673.44898265257;3713.7400381973544;3762.774233545996;3771.358868992278;1124.5501799280353;1140.914431417647;1190.743990042145;1235.9803162391063;1239.5537606461667;727.1637616740685;765.2921048030549;767.8272388712495;839.4543546694697;906.7279816055157;5400.783968641289;5418.729063546885;5570.870720758595;5674.290713660793;5688.971555142198;863.2058506174335;870.7039606533682;898.4699027573763;913.3652111782247;948.9383190092622;3721.3673675475234;3746.9437958430644;3866.574676785551;3917.5886531914307;3922.980385098056;8375.790605234917;9334.39326443779;9548.140667339972;9797.902020979842;9904.009599040039;9819.459929703791;9871.80256394868;9902;9902.257330700082;9903.851442228372;7307.525010874276;7614.847703045908;7677.117131529834;7747.186545412763;7769.067711874498;5540.91688624679;5581.6930068846605;5632.267805185464;5662.688552129673;5710.743016564347;8756.255718263765;8808.735737927873;9015.729528114167;9040.186383225542;9118.99691033999;9159.954200228956;9168.853893263342;9331.206847418045;9380.95309523448;9404.670836520689;6957.512974091765;6967.163940327193;7112.466565007749;7119.537230080028;7125.893111603226;7594.088709354692;7650.081990160994;7706.653200606098;7725.575093369918;7754.418418618739;6898.379145876896;6946.444284457332;7004.264552221944;7033.9296607033275;7116.822079448055;6841.486888483284;6903.0680858083515;6911.170659520689;6949.930500694928;6965.164180298397;6466.191726034246;6480.027995800668;6488.221413430419;6535.183102112236;6554.4756419487285;4661.440627124767;4710.552497512731;4762.880927976828;4792.7124372537755;4812.855614331575;4071.9389209161295;4878.292647566154;4892.559669629751;4942.357493525818;4961.727105009115 04:28:53 INFO - PROCESS | 1647 | |4;prototype.html;303.1194380325156;305.97093276138776;309.41674942732953;315.30475301959166;317.85061021319973;4385.429894113769;4997.250412438131;5073.23901414788;5074.528386767837;5138.691678499288;4011.338129208684;4984.800607975686;4999.675021123624;5009.6242781791325;5011.198208286675;3152.858121384532;3191.856366463503;3512.0868574170645;3513;3986.006996501749;3346.514755360471;3944.3828030507498;3961.6632586230203;3990.481237439129;3996.8601098961544;3497.6852083312497;3897.649211570958;3927.253821773868;3943.46204980058;3946.743461674996;3906.1797022625283;3916.15802602439;3926.782697363826;3936.2914675358425;3939.428782826503;3429.9538640714572;3432.1248081739245;3447.500112483701;3452.482127680843;3452.499387588811;4708.411448568929;4954.033963377143;4989.376327959005;4992.825251116194;5012.598992080625;4141.668666506672;4467.664925130595;4468.2850743881145;4493.2361498545;4498.527654596253;5355.571554275688;5366.865828354284;5368.91946620801;5370.892582148335;5381.9548571542955;3315.126953271394;3762.924741505182;3768.2651882882847;3770.26479836432;3781.2626537825136;4842.588379987706;5346.625736198468;5472.835814925519;5609.80365687199;5616.438356164392;3800.7909564974193;3801.661977883637;3805.991412275749;3812.752171108869;3813.4279858020964;3852.2680690669245;3854.402567602026;3868.7619961612013;3876.825542850522;3884.8834534964;3468.514407982884;4404.009097952999;4446.488653804854;4448.888777780517;4452.376667266585;4935.162281688044;5383.623146379716;5406.729663516809;5414.8628787954185;5429.945700543023;1076.6231818863334;1216.7505661339403;1229.776372509359;1256.6481385212155;1262.2931158551241;691.4744793956629;802.4342838298985;864.6843901975734;874.4173046785339;890.3633901760272;3991.6008399160432;4455.732656040648;4789.95210047895;4803.615710743132;4816.735079570657;4474.619657329164;4509.774511274423;5089.643724939218;5221.060209162387;5238.764255608507;4020.341489244773;4108.506979162519;4360.975170834851;4580.633549316047;4767.76161191946;2261.4120328714325;2276.840621156536;2607.4394005288955;2737.452509498108;2737.945241095167;5370.355557333067;5441.91161767648;5446.400895901447;5455.863603409946;5465.371482279509;4555.886102847389;5237.847673511821;5712;5723.399043100498;5730.914036289459;4874.610031197496;5596.076647353304;5813.372255768391;5823.505002074871;5854.326752423441;4991.950080499294;5173.275741396283;5529.391766905556;5597.63615365;5600.663960162403;4684.641453978308;5471.9179212311055;5526.392096869261;5562.694051827189;5582.609217354746;5119.488051195;5236.528712415901;5760.683162425939;5866.178734977021;5884.675553156565;3109.844507774557;3669.8256557901213;3709.0727318170457;3752.6997840172176;3755.267722794029;5566.972165139148;5567.526760225426;5570.498655121059;5580.693061881473;5583.385827559046;5393;5435.646682965595;5437.265969094122;5453.7818487260065;5454.427285135003;4849.563539281482;5261.421243663271;5404.918926216189;5424.457554244544;5439.782408703608;5084.542391184811;5328.440513746001;5346.251524786455;5346.545543628679;5395.489263006364;5159.767810448614;5318.601104917069;5330.78676852937;5418.536995011404;5425.810096646598;5265.368155821326;5307;5307.920381194363;5313.362396512443;5324.307839980777 04:28:53 INFO - PROCESS | 1647 | |5;yui.html;587.4179815171008;742.528494406052;758.1205801270527;796.1839114907219;796.7291121018852;14426.422943082278;16645.667086658275;17552.385666501643;17578.560535986606;17841.73237401437;15947.474666719967;16297.266623001964;16422.917885410585;16440.177991100427;16533.66932661346;843.6583183810551;869.1308691308691;871.5467956662532;871.5903525343078;872.9214370706635;657.904603832444;677.5155763629004;790.6876783670447;813.6907974969504;860.5912191708919;886.1714297132202;890.3455959869491;896.7040876510736;900.1898291537603;903.7108125399875;886.0297973718767;886.6985225023459;887.3522328700053;888.4047688049022;888.7689200807772;508.1995856525986;526.8630156159388;665.7836203233968;668.0480315550321;669.1902797614891;14706.411743530245;15222.619434514116;15249.466268680542;15620.140892250922;15648.217589120499;13876.514321998782;13941.512047078406;13964.790528141984;14043.578692639136;14087.577372678734;11764;11999.820002699966;12110.455029523693;12163.635090947286;12400.13199076065;3594.4069228577255;3742.3825068863603;3775.0562359410146;3816.160444702161;3816.8473261069526;113460;119056.99999999913;120981;121092;121289;10160.187185025181;10337.844932326021;10386.376817390981;10665.093467055232;10688.412137332365;20939.47651308699;21837.454063648536;21847.781522184574;21900.45248868791;22134.667979980313;7413.443991700644;7440;7472.813179670552;7492.62536873165;7643.1656402463;3611.8735844245325;3746.925061498755;3758.116842542055;3770.6040865709256;3788.8673896413493;3500.107472594523;3535.876244331436;3612.7651702639246;3639.7998110103667;3652.652997965189;616.4051690119056;641.1504756198057;650.5641220382355;659.2649196146358;661.553451420299;591.4765432592187;648.2545073165898;651.7881688451272;669.9564528305644;684.3532861445985;8244.752657420167;8971.282297416321;9392.389494682824;9526.333156678966;9555;543.8939406815633;628;659.5029283526368;678.9830254243585;693.2963042511855;3587.9282414351565;4044.6359827615656;4511.3458548510935;4589.586937175603;4683.882902927386;97122;112527;119172.76131154515;121585;122281;82740;90119.54940225388;95280.6135202433;97324.51337743408;97915.02084979201;88307.67538486928;88990.55504722435;91186.54406727923;92028.53985730163;95413.52293238489;9330.393524420891;9539;10053.19574434029;10071.395716257048;10091.495425228562;48386;54963;55108.72445637746;56333;57841.4215857836;75059.37292194746;80190.19809801827;82890.342193157;83668.16331836603;84762;12635.305058221886;12687.475069804694;12723.300218488072;12817.807732884201;13478.19130852152;14282.42870285177;14556.563303100924;14735.189564574051;14760.926195368955;15308.77036844426;13409.128406653535;13811.654708632364;13858.930705346813;14100.647483812987;14307.070040447754;12387.690307742017;12536.660535865116;12682.746345073232;13504;13871.075768102179;12369.443375048324;13375.53185638498;13743.862561374259;13767.793483097561;13778.173309601456;11022.559097636326;11189.272697274651;11445.713857153638;11465.656030319104;11610.37932059014;11284.943575282072;11338.546458141582;11456.885431145582;11599.710007249549;11674.591389301333 04:28:53 INFO - PROCESS | 1647 | __end_tp_report 04:28:53 INFO - PROCESS | 1647 | __start_cc_report 04:28:53 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1744 04:28:53 INFO - PROCESS | 1647 | __end_cc_report 04:28:53 INFO - PROCESS | 1647 | __startTimestamp1480336133302__endTimestamp 04:28:53 INFO - PROCESS | 1647 | 04:28:53 INFO - PROCESS | 1647 | ------- Summary: start ------- 04:28:53 INFO - PROCESS | 1647 | Number of tests: 6 04:28:53 INFO - PROCESS | 1647 | 04:28:53 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5672.21 Median:5771.62 stddev:623.74 (10.8%) stddev-sans-first:597.10 04:28:53 INFO - PROCESS | 1647 | Values: 3293.7 3297.1 3298.9 3333.1 3356.1 5532.5 5587.2 5593.1 5668.8 5681.6 5591.5 5606.4 5617.4 5624.7 5631.9 5110.7 5143.1 5153.9 5161.1 5188.2 5236.4 5237.8 5241.8 5244.3 5257.8 5128.2 5148.4 5191.9 5212.3 5222.9 5204.3 5227.5 5241.1 5248.2 5280.5 5008.3 5105.4 5175.6 5184.9 5195.7 5561.4 5585.7 5626.2 5647.1 5662.5 6164.6 6174.2 6179.2 6181.9 6193.1 6063.1 6257.2 6264.0 6284.3 6289.3 5493.2 5515.2 5520.9 5637.6 5702.9 6107.0 6118.3 6126.1 6127.3 6131.1 5605.6 5741.5 5769.0 5771.6 5812.0 5904.2 5994.8 6034.8 6036.6 6113.4 6132.9 6170.4 6173.1 6179.4 6203.2 6157.8 6177.0 6178.6 6179.7 6186.1 4771.6 4829.0 4872.6 4909.3 4951.7 4326.1 4347.7 4369.2 4391.6 4452.2 5666.8 5725.5 5729.2 5750.0 5752.7 6239.3 6242.5 6248.4 6261.6 6268.6 5506.3 5603.6 5615.4 5678.3 5724.0 5411.9 5425.8 5428.3 5439.5 5442.4 6294.9 6297.2 6303.8 6311.2 6321.7 6016.7 6188.1 6199.5 6230.8 6248.9 6256.3 6281.4 6300.7 6306.0 6339.8 6112.2 6115.6 6116.5 6122.7 6128.5 6099.8 6167.7 6209.0 6214.1 6218.8 5845.0 5877.6 5896.6 6030.5 6067.7 5929.6 5972.6 5983.4 6038.1 6083.3 5774.9 5790.7 5854.2 5857.7 5874.8 5828.8 5949.0 5971.7 6059.1 6063.4 5721.2 5733.2 5737.9 5741.2 5849.1 04:28:53 INFO - PROCESS | 1647 | 04:28:53 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:67088.63 Median:36330.54 stddev:147304.90 (405.5%) stddev-sans-first:147633.16 04:28:53 INFO - PROCESS | 1647 | Values: 449.2 450.3 481.6 513.6 516.3 25089.1 38003.8 38847.2 38892.0 39041.4 39725.0 40153.0 40420.8 40850.2 40902.4 8388.7 9207.1 9386.7 9396.0 9405.7 8534.6 10882.0 11148.2 11176.4 11355.5 11112.7 11197.8 11212.8 11221.3 11241.7 11091.1 11141.6 11166.6 11183.4 11185.2 11043.3 11136.8 11137.6 11141.5 11152.2 37519.6 37801.6 37852.8 37854.6 37863.4 3225.2 3445.6 3588.0 3773.7 3838.3 22484.6 29306.4 29543.6 29635.1 29851.0 3116.2 3208.1 3217.9 3263.4 3279.8 375054.0 494977.0 496773.0 497031.0 499571.0 54838.7 55343.0 55485.9 55549.5 55606.0 57600.4 57852.7 57856.7 57926.1 57966.1 15250.0 15473.8 15503.7 15513.1 15533.5 10967.0 11795.6 12145.1 12229.4 12230.2 12875.4 13303.7 14309.2 14413.8 14606.0 6311.3 6439.1 6467.6 6467.6 6490.8 891.5 934.3 973.3 1008.1 1094.2 23806.0 28904.0 29330.4 29594.9 29681.4 1042.1 1047.0 1062.1 1095.0 1118.3 14848.9 14852.9 14885.3 15214.1 15224.7 570673.0 652899.0 655146.0 658199.1 661625.0 55284.4 55362.4 55407.9 55440.4 55555.7 1200.4 1252.9 1329.1 1358.8 1379.8 23971.0 28493.7 29622.9 29763.6 29838.4 45716.5 46335.6 46373.0 46411.3 46438.8 522106.0 523544.0 523889.0 524458.0 524484.4 24214.0 24852.5 25785.4 25798.4 33720.0 44346.8 44759.3 45052.9 45301.1 45955.5 36748.8 37201.1 37437.4 37861.0 38038.2 36772.6 37090.8 37603.6 37848.6 38082.4 36078.8 36582.3 36582.8 36630.5 37139.3 30805.2 31837.5 32872.8 33077.2 33138.8 20129.3 20832.7 24064.5 24725.4 24809.0 04:28:53 INFO - PROCESS | 1647 | 04:28:53 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:32792.37 Median:20373.44 stddev:92618.38 (454.6%) stddev-sans-first:92846.16 04:28:53 INFO - PROCESS | 1647 | Values: 348.5 357.2 361.4 369.4 396.9 14531.0 14742.3 15544.8 19416.9 19926.0 15517.3 18252.5 20194.8 20466.3 20471.7 5164.2 5450.4 5451.9 5458.2 5468.2 4225.6 4669.0 5385.9 5389.9 5429.6 5409.7 5425.7 5432.2 5435.0 5463.9 5328.5 5417.0 5828.1 5896.7 5902.9 5193.3 5195.5 5208.9 5220.2 5242.6 12761.3 12958.2 13115.3 13117.4 15870.8 2124.7 2127.3 2143.3 2207.5 2635.4 9792.4 10310.4 10340.4 10937.8 11571.2 1778.8 1783.7 1838.8 1852.0 1927.8 78727.6 96390.5 108297.0 119026.0 119351.4 10972.4 10978.3 11334.3 11384.0 11615.9 13903.2 14262.9 14339.4 14346.4 14416.1 7953.8 8219.6 8242.5 8331.5 8348.4 8085.9 8093.4 8095.2 8225.8 8256.2 4342.5 4412.4 4472.1 4497.9 4507.7 1663.1 1825.0 1884.4 1885.9 1896.2 670.3 764.9 815.5 929.6 947.7 19609.7 19931.6 20345.1 20401.8 20565.2 759.0 892.8 909.5 922.8 979.0 10155.8 10660.8 10722.1 10744.6 10765.5 531384.0 558837.0 560610.0 560632.7 564290.6 97561.0 110215.0 124257.0 124792.2 127055.0 934.3 957.5 976.2 977.5 985.6 14849.3 15100.6 15920.8 17907.3 18490.6 41782.4 50413.0 51446.4 52748.2 56897.4 76806.6 80014.0 80642.0 83078.6 85909.0 11351.7 11819.6 11974.0 12149.8 12165.1 13181.4 13322.9 13609.4 13655.2 13673.9 11100.8 11440.4 11899.2 11909.9 12012.6 10589.8 11212.1 11357.6 11590.9 11916.8 9894.4 10014.7 11726.6 11769.2 11816.2 11837.5 11843.8 11978.6 12008.4 12167.9 11519.5 11569.7 11653.5 11707.1 11851.8 04:28:53 INFO - PROCESS | 1647 | 04:28:53 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5329.61 Median:5409.76 stddev:2883.61 (53.3%) stddev-sans-first:2876.77 04:28:53 INFO - PROCESS | 1647 | Values: 1424.5 1476.0 1611.4 1781.3 1845.3 7372.4 7630.9 7877.6 8220.6 8240.0 7508.8 7861.7 8044.2 8045.7 8152.3 2265.8 2295.7 2296.6 2306.1 2311.5 2050.1 2246.4 2281.9 2293.4 2295.8 2072.3 2208.4 2276.4 2281.0 2284.0 2223.5 2250.1 2250.7 2251.5 2251.7 2230.6 2278.8 2282.7 2284.8 2287.2 8107.4 8176.9 8184.6 8187.3 8204.0 4979.2 5136.2 5159.5 5159.9 5166.3 3148.5 3223.1 3488.3 3490.4 3500.3 1031.7 1046.5 1058.5 1070.9 1073.2 10466.4 10469.6 10619.9 10634.3 10634.7 4371.3 4466.7 4546.0 4553.6 4628.2 9132.7 9140.8 9149.3 9157.3 9162.2 5110.5 5113.4 5132.1 5136.3 5136.5 4665.8 4680.9 4699.8 4722.0 4752.4 3636.8 3673.4 3713.7 3762.8 3771.4 1124.6 1140.9 1190.7 1236.0 1239.6 727.2 765.3 767.8 839.5 906.7 5400.8 5418.7 5570.9 5674.3 5689.0 863.2 870.7 898.5 913.4 948.9 3721.4 3746.9 3866.6 3917.6 3923.0 8375.8 9334.4 9548.1 9797.9 9904.0 9819.5 9871.8 9902.0 9902.3 9903.9 7307.5 7614.8 7677.1 7747.2 7769.1 5540.9 5581.7 5632.3 5662.7 5710.7 8756.3 8808.7 9015.7 9040.2 9119.0 9160.0 9168.9 9331.2 9381.0 9404.7 6957.5 6967.2 7112.5 7119.5 7125.9 7594.1 7650.1 7706.7 7725.6 7754.4 6898.4 6946.4 7004.3 7033.9 7116.8 6841.5 6903.1 6911.2 6949.9 6965.2 6466.2 6480.0 6488.2 6535.2 6554.5 4661.4 4710.6 4762.9 4792.7 4812.9 4071.9 4878.3 4892.6 4942.4 4961.7 04:28:53 INFO - PROCESS | 1647 | 04:28:53 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4348.36 Median:4944.60 stddev:1354.00 (27.4%) stddev-sans-first:1323.31 04:28:53 INFO - PROCESS | 1647 | Values: 303.1 306.0 309.4 315.3 317.9 4385.4 4997.3 5073.2 5074.5 5138.7 4011.3 4984.8 4999.7 5009.6 5011.2 3152.9 3191.9 3512.1 3513.0 3986.0 3346.5 3944.4 3961.7 3990.5 3996.9 3497.7 3897.6 3927.3 3943.5 3946.7 3906.2 3916.2 3926.8 3936.3 3939.4 3430.0 3432.1 3447.5 3452.5 3452.5 4708.4 4954.0 4989.4 4992.8 5012.6 4141.7 4467.7 4468.3 4493.2 4498.5 5355.6 5366.9 5368.9 5370.9 5382.0 3315.1 3762.9 3768.3 3770.3 3781.3 4842.6 5346.6 5472.8 5609.8 5616.4 3800.8 3801.7 3806.0 3812.8 3813.4 3852.3 3854.4 3868.8 3876.8 3884.9 3468.5 4404.0 4446.5 4448.9 4452.4 4935.2 5383.6 5406.7 5414.9 5429.9 1076.6 1216.8 1229.8 1256.6 1262.3 691.5 802.4 864.7 874.4 890.4 3991.6 4455.7 4790.0 4803.6 4816.7 4474.6 4509.8 5089.6 5221.1 5238.8 4020.3 4108.5 4361.0 4580.6 4767.8 2261.4 2276.8 2607.4 2737.5 2737.9 5370.4 5441.9 5446.4 5455.9 5465.4 4555.9 5237.8 5712.0 5723.4 5730.9 4874.6 5596.1 5813.4 5823.5 5854.3 4992.0 5173.3 5529.4 5597.6 5600.7 4684.6 5471.9 5526.4 5562.7 5582.6 5119.5 5236.5 5760.7 5866.2 5884.7 3109.8 3669.8 3709.1 3752.7 3755.3 5567.0 5567.5 5570.5 5580.7 5583.4 5393.0 5435.6 5437.3 5453.8 5454.4 4849.6 5261.4 5404.9 5424.5 5439.8 5084.5 5328.4 5346.3 5346.5 5395.5 5159.8 5318.6 5330.8 5418.5 5425.8 5265.4 5307.0 5307.9 5313.4 5324.3 04:28:53 INFO - PROCESS | 1647 | 04:28:53 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:22202.75 Median:3744.65 stddev:33181.37 (886.1%) stddev-sans-first:33234.76 04:28:53 INFO - PROCESS | 1647 | Values: 587.4 742.5 758.1 796.2 796.7 14426.4 16645.7 17552.4 17578.6 17841.7 15947.5 16297.3 16422.9 16440.2 16533.7 843.7 869.1 871.5 871.6 872.9 657.9 677.5 790.7 813.7 860.6 886.2 890.3 896.7 900.2 903.7 886.0 886.7 887.4 888.4 888.8 508.2 526.9 665.8 668.0 669.2 14706.4 15222.6 15249.5 15620.1 15648.2 13876.5 13941.5 13964.8 14043.6 14087.6 11764.0 11999.8 12110.5 12163.6 12400.1 3594.4 3742.4 3775.1 3816.2 3816.8 113460.0 119057.0 120981.0 121092.0 121289.0 10160.2 10337.8 10386.4 10665.1 10688.4 20939.5 21837.5 21847.8 21900.5 22134.7 7413.4 7440.0 7472.8 7492.6 7643.2 3611.9 3746.9 3758.1 3770.6 3788.9 3500.1 3535.9 3612.8 3639.8 3652.7 616.4 641.2 650.6 659.3 661.6 591.5 648.3 651.8 670.0 684.4 8244.8 8971.3 9392.4 9526.3 9555.0 543.9 628.0 659.5 679.0 693.3 3587.9 4044.6 4511.3 4589.6 4683.9 97122.0 112527.0 119172.8 121585.0 122281.0 82740.0 90119.5 95280.6 97324.5 97915.0 88307.7 88990.6 91186.5 92028.5 95413.5 9330.4 9539.0 10053.2 10071.4 10091.5 48386.0 54963.0 55108.7 56333.0 57841.4 75059.4 80190.2 82890.3 83668.2 84762.0 12635.3 12687.5 12723.3 12817.8 13478.2 14282.4 14556.6 14735.2 14760.9 15308.8 13409.1 13811.7 13858.9 14100.6 14307.1 12387.7 12536.7 12682.7 13504.0 13871.1 12369.4 13375.5 13743.9 13767.8 13778.2 11022.6 11189.3 11445.7 11465.7 11610.4 11284.9 11338.5 11456.9 11599.7 11674.6 04:28:53 INFO - PROCESS | 1647 | -------- Summary: end -------- 04:28:53 INFO - PROCESS | 1647 | 04:28:53 INFO - TEST-INFO | 1647: exit 0 04:28:53 INFO - TEST-OK | dromaeo_css | took 1120770ms 04:28:53 INFO - TEST-START | kraken 04:28:53 INFO - operating with platform_type : mac_ 04:28:53 INFO - Initialising browser for kraken test... 04:28:54 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpz7qfQs/profile http://localhost:49241/getInfo.html) 04:28:56 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 04:28:56 INFO - PROCESS | 1652 | colorDepth:24 04:28:56 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 04:28:56 INFO - PROCESS | 1652 | __metrics 04:28:56 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:28:56 INFO - PROCESS | 1652 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:57 INFO - TEST-INFO | 1652: exit 0 04:28:57 INFO - Browser initialized. 04:28:57 INFO - Running cycle 1/1 for kraken test... 04:28:57 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpz7qfQs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:10 INFO - PROCESS | 1653 | RSS: Main: 245231616 04:29:10 INFO - PROCESS | 1653 | 04:29:12 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 04:29:13 INFO - PROCESS | 1653 | RSS: Main: 295669760 04:29:13 INFO - PROCESS | 1653 | 04:29:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 04:29:17 INFO - PROCESS | 1653 | RSS: Main: 296890368 04:29:17 INFO - PROCESS | 1653 | 04:29:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 04:29:21 INFO - PROCESS | 1653 | RSS: Main: 388485120 04:29:21 INFO - PROCESS | 1653 | 04:29:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 04:29:23 INFO - PROCESS | 1653 | RSS: Main: 291172352 04:29:23 INFO - PROCESS | 1653 | 04:29:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:29:26 INFO - PROCESS | 1653 | RSS: Main: 293380096 04:29:26 INFO - PROCESS | 1653 | 04:29:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 04:29:29 INFO - PROCESS | 1653 | RSS: Main: 335228928 04:29:29 INFO - PROCESS | 1653 | 04:29:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 04:29:33 INFO - PROCESS | 1653 | RSS: Main: 336412672 04:29:33 INFO - PROCESS | 1653 | 04:29:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 04:29:36 INFO - PROCESS | 1653 | RSS: Main: 333672448 04:29:36 INFO - PROCESS | 1653 | 04:29:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:39 INFO - PROCESS | 1653 | RSS: Main: 312123392 04:29:39 INFO - PROCESS | 1653 | 04:29:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:41 INFO - PROCESS | 1653 | RSS: Main: 315699200 04:29:41 INFO - PROCESS | 1653 | 04:29:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:44 INFO - PROCESS | 1653 | RSS: Main: 318009344 04:29:44 INFO - PROCESS | 1653 | 04:29:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:48 INFO - PROCESS | 1653 | RSS: Main: 335556608 04:29:48 INFO - PROCESS | 1653 | 04:29:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:52 INFO - PROCESS | 1653 | RSS: Main: 328716288 04:29:52 INFO - PROCESS | 1653 | 04:29:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 04:29:54 INFO - PROCESS | 1653 | RSS: Main: 372518912 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | __start_tp_report 04:29:54 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 04:29:54 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 04:29:54 INFO - PROCESS | 1653 | |i|pagename|runs| 04:29:54 INFO - PROCESS | 1653 | |0;ai-astar;111;112;112;112;111;112;112;111;111;111 04:29:54 INFO - PROCESS | 1653 | |1;audio-beat-detection;145;123;102;168;146;141;130;112;135;114 04:29:54 INFO - PROCESS | 1653 | |2;audio-dft;185;184;182;184;184;181;191;259;183;194 04:29:54 INFO - PROCESS | 1653 | |3;audio-fft;78;59;77;112;85;81;59;57;74;73 04:29:54 INFO - PROCESS | 1653 | |4;audio-oscillator;82;74;85;69;68;69;82;67;69;83 04:29:54 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;87;85;86;85;87;84;88;84;87;83 04:29:54 INFO - PROCESS | 1653 | |6;imaging-darkroom;93;92;94;93;92;92;94;93;108;148 04:29:54 INFO - PROCESS | 1653 | |7;imaging-desaturate;89;85;85;86;87;94;135;138;87;84 04:29:54 INFO - PROCESS | 1653 | |8;json-parse-financial;53;53;54;55;54;58;54;55;53;54 04:29:54 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;65;77;72;77;74;69;71;70;71;70 04:29:54 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;88;87;88;88;87;89;87;90;108;94 04:29:54 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;155;149;161;142;165;155;165;158;222;175 04:29:54 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;172;173;173;151;233;234;172;173;174;171 04:29:54 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;70;70;69;70;70;71;67;69;68;71 04:29:54 INFO - PROCESS | 1653 | __end_tp_report 04:29:54 INFO - PROCESS | 1653 | __start_cc_report 04:29:54 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1956 04:29:54 INFO - PROCESS | 1653 | __end_cc_report 04:29:54 INFO - PROCESS | 1653 | __startTimestamp1480336194060__endTimestamp 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | ------- Summary: start ------- 04:29:54 INFO - PROCESS | 1653 | Number of tests: 14 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:29:54 INFO - PROCESS | 1653 | Values: 111.0 112.0 112.0 112.0 111.0 112.0 112.0 111.0 111.0 111.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:138.00 stddev:19.60 (14.2%) stddev-sans-first:20.18 04:29:54 INFO - PROCESS | 1653 | Values: 145.0 123.0 102.0 168.0 146.0 141.0 130.0 112.0 135.0 114.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:192.70 Median:184.50 stddev:23.65 (12.8%) stddev-sans-first:24.92 04:29:54 INFO - PROCESS | 1653 | Values: 185.0 184.0 182.0 184.0 184.0 181.0 191.0 259.0 183.0 194.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:75.50 Median:75.50 stddev:16.18 (21.4%) stddev-sans-first:17.14 04:29:54 INFO - PROCESS | 1653 | Values: 78.0 59.0 77.0 112.0 85.0 81.0 59.0 57.0 74.0 73.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:74.80 Median:78.00 stddev:7.33 (9.4%) stddev-sans-first:7.30 04:29:54 INFO - PROCESS | 1653 | Values: 82.0 74.0 85.0 69.0 68.0 69.0 82.0 67.0 69.0 83.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.50 stddev:1.65 (1.9%) stddev-sans-first:1.67 04:29:54 INFO - PROCESS | 1653 | Values: 87.0 85.0 86.0 85.0 87.0 84.0 88.0 84.0 87.0 83.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:93.00 stddev:17.57 (18.9%) stddev-sans-first:18.46 04:29:54 INFO - PROCESS | 1653 | Values: 93.0 92.0 94.0 93.0 92.0 92.0 94.0 93.0 108.0 148.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:86.50 stddev:21.02 (24.3%) stddev-sans-first:22.09 04:29:54 INFO - PROCESS | 1653 | Values: 89.0 85.0 85.0 86.0 87.0 94.0 135.0 138.0 87.0 84.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:1.49 (2.8%) stddev-sans-first:1.51 04:29:54 INFO - PROCESS | 1653 | Values: 53.0 53.0 54.0 55.0 54.0 58.0 54.0 55.0 53.0 54.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.50 stddev:3.66 (5.1%) stddev-sans-first:3.00 04:29:54 INFO - PROCESS | 1653 | Values: 65.0 77.0 72.0 77.0 74.0 69.0 71.0 70.0 71.0 70.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:88.00 stddev:6.47 (7.3%) stddev-sans-first:6.79 04:29:54 INFO - PROCESS | 1653 | Values: 88.0 87.0 88.0 88.0 87.0 89.0 87.0 90.0 108.0 94.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:164.70 Median:163.00 stddev:22.11 (13.6%) stddev-sans-first:23.17 04:29:54 INFO - PROCESS | 1653 | Values: 155.0 149.0 161.0 142.0 165.0 155.0 165.0 158.0 222.0 175.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.60 Median:173.00 stddev:27.67 (16.0%) stddev-sans-first:29.08 04:29:54 INFO - PROCESS | 1653 | Values: 172.0 173.0 173.0 151.0 233.0 234.0 172.0 173.0 174.0 171.0 04:29:54 INFO - PROCESS | 1653 | 04:29:54 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.27 (1.8%) stddev-sans-first:1.33 04:29:54 INFO - PROCESS | 1653 | Values: 70.0 70.0 69.0 70.0 70.0 71.0 67.0 69.0 68.0 71.0 04:29:54 INFO - PROCESS | 1653 | -------- Summary: end -------- 04:29:54 INFO - PROCESS | 1653 | 04:29:55 INFO - TEST-INFO | 1653: exit 0 04:29:55 INFO - TEST-OK | kraken | took 61142ms 04:29:55 INFO - SUITE-END | took 1181s 04:29:55 INFO - Completed test suite (00:19:41) 04:29:55 INFO - javascript benchmark 04:29:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.720033797128, 3297.0768184908225, 3298.901032969012, 3333.050080726993, 3356.0770788033287, 5532.502074813266, 5587.189857470669, 5593.105103183491, 5668.801591944282, 5681.602287839853, 5591.4688104630095, 5606.383297837235, 5617.4382561743805, 5624.690642014698, 5631.8592035199035, 5110.7444627768555, 5143.099957507421, 5153.896922061556, 5161.096808058574, 5188.16989281715, 5236.423993360727, 5237.79048838046, 5241.816536421226, 5244.344456942882, 5257.789688412459, 5128.179491281396, 5148.382194136709, 5191.87020324493, 5212.270282160501, 5222.895542089156, 5204.271402003704, 5227.503387178212, 5241.056609810233, 5248.21276808478, 5280.471952804727, 5008.29883816266, 5105.438401775802, 5175.637705360627, 5184.8963020739375, 5195.68825870449, 5561.443855614447, 5585.720713964285, 5626.156076588503, 5647.124695672177, 5662.546996240291, 6164.599301045462, 6174.166487524171, 6179.227596550431, 6181.907271390933, 6193.1329613854095, 6063.120847477091, 6257.217847769029, 6263.997760358321, 6284.340144284875, 6289.276733175698, 5493.2034854945805, 5515.172724091419, 5520.91718624221, 5637.605367624268, 5702.914456283159, 6107.044717083349, 6118.324106893939, 6126.070442333212, 6127.26157773244, 6131.113028989343, 5605.635633683797, 5741.5119714824705, 5768.990426675315, 5771.6248443851855, 5812.0, 5904.232449781587, 5994.820155395345, 6034.818955431344, 6036.63780173191, 6113.385090541919, 6132.908006379907, 6170.382961703884, 6173.074038894202, 6179.3820617937845, 6203.193584833943, 6157.8460538486, 6177.042558403455, 6178.598391104653, 6179.721912513858, 6186.072089186568, 4771.618270538349, 4829.0, 4872.585830204473, 4909.26361045846, 4951.72765497901, 4326.091520780671, 4347.7173983690955, 4369.235383807821, 4391.626711729475, 4452.243118669834, 5666.801661941812, 5725.541956643458, 5729.197912292282, 5750.02249617566, 5752.683602401824, 6239.282482514569, 6242.500599951993, 6248.375162483715, 6261.624302541862, 6268.623882567061, 5506.256655351476, 5603.635763675348, 5615.354234263031, 5678.3186017678145, 5723.971380143073, 5411.918821217685, 5425.7829686812875, 5428.294321738228, 5439.456054394529, 5442.428545002796, 6294.937050629526, 6297.2128483939505, 6303.810885673437, 6311.179546658905, 6321.715522801485, 6016.729247183975, 6188.071789231652, 6199.473044791243, 6230.7507699691505, 6248.906266406098, 6256.280527739368, 6281.434670879643, 6300.71646775887, 6305.96847015762, 6339.778107766206, 6112.169143789106, 6115.602485838406, 6116.518381401779, 6122.672617327995, 6128.503123582109, 6099.847503812262, 6167.6916154193, 6209.0, 6214.098955651315, 6218.844528886814, 5844.970775146097, 5877.647341159544, 5896.55775816824, 6030.517558595389, 6067.7431588192485, 5929.584929055098, 5972.611780234271, 5983.431574000463, 6038.064100064497, 6083.270007599116, 5774.855628609318, 5790.652560846363, 5854.2389489366105, 5857.736401861841, 5874.823755287348, 5828.795992140254, 5949.0, 5971.701414929149, 6059.121427392915, 6063.423974722395, 5721.22763426932, 5733.197352370588, 5737.942620573908, 5741.196232527366, 5849.1226316052935], "value": 5631.774725772218, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.18697158143743, 450.25482825923086, 481.5906479492432, 513.6327525819039, 516.3133033066023, 25089.12188073418, 38003.80998095009, 38847.223055538874, 38891.99999999996, 39041.41437878434, 39725.0, 40152.996175095635, 40420.797896010554, 40850.18299634005, 40902.38646420306, 8388.706395276167, 9207.125323094311, 9386.671466498674, 9395.953020234923, 9405.717828465156, 8534.61594228258, 10882.0, 11148.21962462628, 11176.385298808604, 11355.545778168864, 11112.722181945435, 11197.776044479106, 11212.831807522894, 11221.270617409842, 11241.66275011751, 11091.057260132899, 11141.610043648514, 11166.609168679099, 11183.384913829736, 11185.217034807567, 11043.282186657922, 11136.777264454746, 11137.610183643534, 11141.498632561474, 11152.16358773087, 37519.62480375189, 37801.62198378008, 37852.81073594614, 37854.62145378539, 37863.432048519295, 3225.209823593235, 3445.620981692012, 3587.964120358789, 3773.735838491307, 3838.251540949516, 22484.550308993894, 29306.413871722445, 29543.556846647316, 29635.11094667142, 29851.0, 3116.2209447638093, 3208.0696597986557, 3217.9034628961167, 3263.379957808009, 3279.7868138570916, 375054.0, 494977.0, 496773.0, 497031.0, 499571.0, 54838.72580637151, 55343.0, 55485.89028219494, 55549.500272487836, 55606.0, 57600.423995759505, 57852.710736446046, 57856.71071644615, 57926.13110803341, 57966.13050804241, 15250.0, 15473.84526154724, 15503.689926201412, 15513.146776927377, 15533.45632902843, 10967.0, 11795.587154449553, 12145.089118316162, 12229.388530573437, 12230.205036672587, 12875.420606072748, 13303.66740831487, 14309.21299328526, 14413.78379324311, 14606.0, 6311.274203466568, 6439.098526206335, 6467.611943283324, 6467.611943283418, 6490.837729056811, 891.5007595746403, 934.2712684106408, 973.2846357926918, 1008.1430783833829, 1094.195766111907, 23806.0, 28903.988360407704, 29330.413391732047, 29594.852025740165, 29681.406371872872, 1042.1089968077335, 1047.0471870597719, 1062.1131355318396, 1095.0, 1118.2898859224288, 14848.851511484963, 14852.851471485363, 14885.255737213096, 15214.087154770748, 15224.695506090038, 570673.0, 652899.0, 655146.0, 658199.1431156732, 661625.0, 55284.44715552873, 55362.40144390602, 55407.89184216293, 55440.44559554433, 55555.722221388634, 1200.3938011304235, 1252.8872401483727, 1329.1427029566069, 1358.7690092684268, 1379.8137251471123, 23971.04115835347, 28493.71778270024, 29622.851885741296, 29763.55354669725, 29838.403231935674, 45716.54283457123, 46335.6099317021, 46373.0, 46411.303830441895, 46438.839029024544, 522106.0, 523544.0, 523889.0, 524458.0, 524484.377578125, 24214.03143874225, 24852.502949941263, 25785.355366115997, 25798.356295866924, 33720.0, 44346.778266108464, 44759.328610070224, 45052.87367815831, 45301.09397812091, 45955.54044459513, 36748.81625591855, 37201.0699732498, 37437.4384384229, 37861.0, 38038.23923521459, 36772.63227367692, 37090.814545927096, 37603.623963760016, 37848.62151378451, 38082.428763568016, 36078.8196059018, 36582.26835463329, 36582.8170859144, 36630.450543242405, 37139.257214856094, 30805.22986925345, 31837.522437163, 32872.849450269125, 33077.17307067246, 33138.83430582831, 20129.295474658316, 20832.687509687064, 24064.518709625358, 24725.381865453506, 24809.0], "value": 19295.320693654954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.5434081353429, 357.1963083063107, 361.392859995208, 369.4163222109068, 396.90275882408815, 14531.0, 14742.33659485323, 15544.76682849758, 19416.90291548544, 19926.0, 15517.301721422535, 18252.543686407815, 20194.798052019476, 20466.2836800712, 20471.692924606104, 5164.1995490699, 5450.373207081177, 5451.945480545183, 5458.153986132156, 5468.152436372368, 4225.598568136037, 4668.996165824347, 5385.919211211835, 5389.946100539003, 5429.619926605139, 5409.729513524328, 5425.701586412765, 5432.185172224158, 5435.0488664483755, 5463.863403414926, 5328.5470734987375, 5417.0, 5828.0966450200285, 5896.734646940855, 5902.881942361171, 5193.272941788153, 5195.480451954812, 5208.947910520884, 5220.190870415054, 5242.580593552507, 12761.298128602923, 12958.22250664963, 13115.344232788322, 13117.409716562777, 15870.841291587052, 2124.702541644171, 2127.319257837493, 2143.3141394753684, 2207.4812419081504, 2635.393859412327, 9792.363496372713, 10310.381377117397, 10340.37957722539, 10937.83593246102, 11571.190016698834, 1778.7509748635202, 1783.6967715488267, 1838.834504894566, 1851.9722204166949, 1927.816857398545, 78727.6063619684, 96390.51804741002, 108297.0, 119026.0, 119351.4032429841, 10972.396518191417, 10978.286411383235, 11334.263272887236, 11384.0, 11615.941920290345, 13903.235322057384, 14262.928685356506, 14339.354729037219, 14346.354414051393, 14416.13503189812, 7953.812701507132, 8219.630116644765, 8242.505449673039, 8331.458455200393, 8348.373871959628, 8085.878711819328, 8093.352531797442, 8095.190480951857, 8225.79435514105, 8256.174382561696, 4342.505230744915, 4412.404325416028, 4472.105578884236, 4497.865064048084, 4507.706999045052, 1663.0853030833234, 1824.9635007300046, 1884.396992962239, 1885.9151338189815, 1896.2035944903173, 670.3229737964572, 764.8869102751858, 815.4862436664981, 929.5770424456856, 947.7346343023964, 19609.705854412194, 19931.63917372584, 20345.084471198832, 20401.795982040287, 20565.177392904414, 758.9772306830804, 892.7634176943116, 909.4725059465494, 922.796984663373, 978.9720793167146, 10155.847662285072, 10660.786784264272, 10722.088622467178, 10744.623938162127, 10765.46172691378, 531384.0, 558837.0, 560609.9695015233, 560632.7011280525, 564290.5709429025, 97561.02438975661, 110215.0, 124257.0, 124792.16921512714, 127055.0, 934.2666007184328, 957.4973139102027, 976.1897624971399, 977.5112443778111, 985.6402413119304, 14849.331780069706, 15100.622484437978, 15920.805939554812, 17907.283708651506, 18490.630187396448, 41782.37326440045, 50413.0, 51446.42455447494, 52748.20877686914, 56897.43102569087, 76806.61596691981, 80014.0, 80642.0, 83078.58460707658, 85909.0, 11351.716207094889, 11819.645410637695, 11974.0, 12149.75700486003, 12165.08761842883, 13181.35233095863, 13322.933385333012, 13609.387577559231, 13655.180689158682, 13673.86326136726, 11100.777984440105, 11440.370779607201, 11899.167058305835, 11909.880901190878, 12012.579559715368, 10589.78217504966, 11212.103031757277, 11357.602483913024, 11590.94204528972, 11916.761664766484, 9894.406335619886, 10014.749631259278, 11726.648200553997, 11769.234999724991, 11816.172867899164, 11837.526498939946, 11843.763124737628, 11978.580749674069, 12008.39958002114, 12167.87832121703, 11519.481623326803, 11569.6529104127, 11653.475593598478, 11707.063434925016, 11851.822222666839], "value": 9251.922822317152, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.4871846135393, 1475.977860332095, 1611.4440518021286, 1781.2963879267697, 1845.2711179084263, 7372.410207183426, 7630.8855367169535, 7877.566733829644, 8220.630071646776, 8240.011198656162, 7508.849823003537, 7861.724839630614, 8044.235797599234, 8045.678172873078, 8152.2662960333555, 2265.762094980032, 2295.701558797354, 2296.575133600281, 2306.1006207579057, 2311.526137141882, 2050.128695304497, 2246.359787460574, 2281.9201327953524, 2293.4381076636246, 2295.8392912496133, 2072.3472106286545, 2208.4147700859285, 2276.4195130241847, 2281.0, 2284.0, 2223.5108276179217, 2250.144944920936, 2250.7411647660565, 2251.4821591034074, 2251.6960210371553, 2230.631945728969, 2278.8063014643776, 2282.7488976212603, 2284.7829456201634, 2287.176616418088, 8107.432479726422, 8176.877346839802, 8184.590770461453, 8187.345012398994, 8203.9745031871, 4979.203327467588, 5136.178211486182, 5159.509846564571, 5159.948400515985, 5166.328377310925, 3148.511980643004, 3223.1458663454205, 3488.3372159289906, 3490.371733088043, 3500.334936362083, 1031.742064483879, 1046.4832078850302, 1058.544825724938, 1070.8768491623484, 1073.2165519170971, 10466.424346660931, 10469.581216751321, 10619.946900265526, 10634.255602107778, 10634.680959571226, 4371.322445021026, 4466.665000125004, 4545.999880026389, 4553.567411095941, 4628.213203755369, 9132.680356187502, 9140.771480713036, 9149.268058555299, 9157.267418606496, 9162.22121119699, 5110.4634013428795, 5113.437521872591, 5132.050570644443, 5136.280920671109, 5136.512031357015, 4665.790039448233, 4680.882977925579, 4699.78850951708, 4721.952780472151, 4752.382190315306, 3636.7636103653176, 3673.44898265257, 3713.7400381973544, 3762.774233545996, 3771.358868992278, 1124.5501799280353, 1140.914431417647, 1190.743990042145, 1235.9803162391063, 1239.5537606461667, 727.1637616740685, 765.2921048030549, 767.8272388712495, 839.4543546694697, 906.7279816055157, 5400.783968641289, 5418.729063546885, 5570.870720758595, 5674.290713660793, 5688.971555142198, 863.2058506174335, 870.7039606533682, 898.4699027573763, 913.3652111782247, 948.9383190092622, 3721.3673675475234, 3746.9437958430644, 3866.574676785551, 3917.5886531914307, 3922.980385098056, 8375.790605234917, 9334.39326443779, 9548.140667339972, 9797.902020979842, 9904.009599040039, 9819.459929703791, 9871.80256394868, 9902.0, 9902.257330700082, 9903.851442228372, 7307.525010874276, 7614.847703045908, 7677.117131529834, 7747.186545412763, 7769.067711874498, 5540.91688624679, 5581.6930068846605, 5632.267805185464, 5662.688552129673, 5710.743016564347, 8756.255718263765, 8808.735737927873, 9015.729528114167, 9040.186383225542, 9118.99691033999, 9159.954200228956, 9168.853893263342, 9331.206847418045, 9380.95309523448, 9404.670836520689, 6957.512974091765, 6967.163940327193, 7112.466565007749, 7119.537230080028, 7125.893111603226, 7594.088709354692, 7650.081990160994, 7706.653200606098, 7725.575093369918, 7754.418418618739, 6898.379145876896, 6946.444284457332, 7004.264552221944, 7033.9296607033275, 7116.822079448055, 6841.486888483284, 6903.0680858083515, 6911.170659520689, 6949.930500694928, 6965.164180298397, 6466.191726034246, 6480.027995800668, 6488.221413430419, 6535.183102112236, 6554.4756419487285, 4661.440627124767, 4710.552497512731, 4762.880927976828, 4792.7124372537755, 4812.855614331575, 4071.9389209161295, 4878.292647566154, 4892.559669629751, 4942.357493525818, 4961.727105009115], "value": 4326.772611810528, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.1194380325156, 305.97093276138776, 309.41674942732953, 315.30475301959166, 317.85061021319973, 4385.429894113769, 4997.250412438131, 5073.23901414788, 5074.528386767837, 5138.691678499288, 4011.338129208684, 4984.800607975686, 4999.675021123624, 5009.6242781791325, 5011.198208286675, 3152.858121384532, 3191.856366463503, 3512.0868574170645, 3513.0, 3986.006996501749, 3346.514755360471, 3944.3828030507498, 3961.6632586230203, 3990.481237439129, 3996.8601098961544, 3497.6852083312497, 3897.649211570958, 3927.253821773868, 3943.46204980058, 3946.743461674996, 3906.1797022625283, 3916.15802602439, 3926.782697363826, 3936.2914675358425, 3939.428782826503, 3429.9538640714572, 3432.1248081739245, 3447.500112483701, 3452.482127680843, 3452.499387588811, 4708.411448568929, 4954.033963377143, 4989.376327959005, 4992.825251116194, 5012.598992080625, 4141.668666506672, 4467.664925130595, 4468.2850743881145, 4493.2361498545, 4498.527654596253, 5355.571554275688, 5366.865828354284, 5368.91946620801, 5370.892582148335, 5381.9548571542955, 3315.126953271394, 3762.924741505182, 3768.2651882882847, 3770.26479836432, 3781.2626537825136, 4842.588379987706, 5346.625736198468, 5472.835814925519, 5609.80365687199, 5616.438356164392, 3800.7909564974193, 3801.661977883637, 3805.991412275749, 3812.752171108869, 3813.4279858020964, 3852.2680690669245, 3854.402567602026, 3868.7619961612013, 3876.825542850522, 3884.8834534964, 3468.514407982884, 4404.009097952999, 4446.488653804854, 4448.888777780517, 4452.376667266585, 4935.162281688044, 5383.623146379716, 5406.729663516809, 5414.8628787954185, 5429.945700543023, 1076.6231818863334, 1216.7505661339403, 1229.776372509359, 1256.6481385212155, 1262.2931158551241, 691.4744793956629, 802.4342838298985, 864.6843901975734, 874.4173046785339, 890.3633901760272, 3991.6008399160432, 4455.732656040648, 4789.95210047895, 4803.615710743132, 4816.735079570657, 4474.619657329164, 4509.774511274423, 5089.643724939218, 5221.060209162387, 5238.764255608507, 4020.341489244773, 4108.506979162519, 4360.975170834851, 4580.633549316047, 4767.76161191946, 2261.4120328714325, 2276.840621156536, 2607.4394005288955, 2737.452509498108, 2737.945241095167, 5370.355557333067, 5441.91161767648, 5446.400895901447, 5455.863603409946, 5465.371482279509, 4555.886102847389, 5237.847673511821, 5712.0, 5723.399043100498, 5730.914036289459, 4874.610031197496, 5596.076647353304, 5813.372255768391, 5823.505002074871, 5854.326752423441, 4991.950080499294, 5173.275741396283, 5529.391766905556, 5597.63615365, 5600.663960162403, 4684.641453978308, 5471.9179212311055, 5526.392096869261, 5562.694051827189, 5582.609217354746, 5119.488051195, 5236.528712415901, 5760.683162425939, 5866.178734977021, 5884.675553156565, 3109.844507774557, 3669.8256557901213, 3709.0727318170457, 3752.6997840172176, 3755.267722794029, 5566.972165139148, 5567.526760225426, 5570.498655121059, 5580.693061881473, 5583.385827559046, 5393.0, 5435.646682965595, 5437.265969094122, 5453.7818487260065, 5454.427285135003, 4849.563539281482, 5261.421243663271, 5404.918926216189, 5424.457554244544, 5439.782408703608, 5084.542391184811, 5328.440513746001, 5346.251524786455, 5346.545543628679, 5395.489263006364, 5159.767810448614, 5318.601104917069, 5330.78676852937, 5418.536995011404, 5425.810096646598, 5265.368155821326, 5307.0, 5307.920381194363, 5313.362396512443, 5324.307839980777], "value": 3916.086170960364, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.4179815171008, 742.528494406052, 758.1205801270527, 796.1839114907219, 796.7291121018852, 14426.422943082278, 16645.667086658275, 17552.385666501643, 17578.560535986606, 17841.73237401437, 15947.474666719967, 16297.266623001964, 16422.917885410585, 16440.177991100427, 16533.66932661346, 843.6583183810551, 869.1308691308691, 871.5467956662532, 871.5903525343078, 872.9214370706635, 657.904603832444, 677.5155763629004, 790.6876783670447, 813.6907974969504, 860.5912191708919, 886.1714297132202, 890.3455959869491, 896.7040876510736, 900.1898291537603, 903.7108125399875, 886.0297973718767, 886.6985225023459, 887.3522328700053, 888.4047688049022, 888.7689200807772, 508.1995856525986, 526.8630156159388, 665.7836203233968, 668.0480315550321, 669.1902797614891, 14706.411743530245, 15222.619434514116, 15249.466268680542, 15620.140892250922, 15648.217589120499, 13876.514321998782, 13941.512047078406, 13964.790528141984, 14043.578692639136, 14087.577372678734, 11764.0, 11999.820002699966, 12110.455029523693, 12163.635090947286, 12400.13199076065, 3594.4069228577255, 3742.3825068863603, 3775.0562359410146, 3816.160444702161, 3816.8473261069526, 113460.0, 119056.99999999913, 120981.0, 121092.0, 121289.0, 10160.187185025181, 10337.844932326021, 10386.376817390981, 10665.093467055232, 10688.412137332365, 20939.47651308699, 21837.454063648536, 21847.781522184574, 21900.45248868791, 22134.667979980313, 7413.443991700644, 7440.0, 7472.813179670552, 7492.62536873165, 7643.1656402463, 3611.8735844245325, 3746.925061498755, 3758.116842542055, 3770.6040865709256, 3788.8673896413493, 3500.107472594523, 3535.876244331436, 3612.7651702639246, 3639.7998110103667, 3652.652997965189, 616.4051690119056, 641.1504756198057, 650.5641220382355, 659.2649196146358, 661.553451420299, 591.4765432592187, 648.2545073165898, 651.7881688451272, 669.9564528305644, 684.3532861445985, 8244.752657420167, 8971.282297416321, 9392.389494682824, 9526.333156678966, 9555.0, 543.8939406815633, 628.0, 659.5029283526368, 678.9830254243585, 693.2963042511855, 3587.9282414351565, 4044.6359827615656, 4511.3458548510935, 4589.586937175603, 4683.882902927386, 97122.0, 112527.0, 119172.76131154515, 121585.0, 122281.0, 82740.0, 90119.54940225388, 95280.6135202433, 97324.51337743408, 97915.02084979201, 88307.67538486928, 88990.55504722435, 91186.54406727923, 92028.53985730163, 95413.52293238489, 9330.393524420891, 9539.0, 10053.19574434029, 10071.395716257048, 10091.495425228562, 48386.0, 54963.0, 55108.72445637746, 56333.0, 57841.4215857836, 75059.37292194746, 80190.19809801827, 82890.342193157, 83668.16331836603, 84762.0, 12635.305058221886, 12687.475069804694, 12723.300218488072, 12817.807732884201, 13478.19130852152, 14282.42870285177, 14556.563303100924, 14735.189564574051, 14760.926195368955, 15308.77036844426, 13409.128406653535, 13811.654708632364, 13858.930705346813, 14100.647483812987, 14307.070040447754, 12387.690307742017, 12536.660535865116, 12682.746345073232, 13504.0, 13871.075768102179, 12369.443375048324, 13375.53185638498, 13743.862561374259, 13767.793483097561, 13778.173309601456, 11022.559097636326, 11189.272697274651, 11445.713857153638, 11465.656030319104, 11610.37932059014, 11284.943575282072, 11338.546458141582, 11456.885431145582, 11599.710007249549, 11674.591389301333], "value": 7573.608851553822, "unit": "score"}], "name": "dromaeo_css", "value": 7108.579805642428, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 112.0, 111.0, 112.0, 112.0, 111.0, 111.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 123.0, 102.0, 168.0, 146.0, 141.0, 130.0, 112.0, 135.0, 114.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 182.0, 184.0, 184.0, 181.0, 191.0, 259.0, 183.0, 194.0], "value": 192.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 77.0, 112.0, 85.0, 81.0, 59.0, 57.0, 74.0, 73.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 85.0, 69.0, 68.0, 69.0, 82.0, 67.0, 69.0, 83.0], "value": 74.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 85.0, 87.0, 84.0, 88.0, 84.0, 87.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 94.0, 93.0, 92.0, 92.0, 94.0, 93.0, 108.0, 148.0], "value": 99.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 85.0, 86.0, 87.0, 94.0, 135.0, 138.0, 87.0, 84.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 55.0, 54.0, 58.0, 54.0, 55.0, 53.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 72.0, 77.0, 74.0, 69.0, 71.0, 70.0, 71.0, 70.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 88.0, 87.0, 89.0, 87.0, 90.0, 108.0, 94.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 149.0, 161.0, 142.0, 165.0, 155.0, 165.0, 158.0, 222.0, 175.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 173.0, 151.0, 233.0, 234.0, 172.0, 173.0, 174.0, 171.0], "value": 182.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 70.0, 70.0, 71.0, 67.0, 69.0, 68.0, 71.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1501.8999999999999, "alertThreshold": 2.0}]} 04:29:55 INFO - Return code: 0 04:29:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:29:55 INFO - # TBPL SUCCESS # 04:29:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:29:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:29:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:29:55 INFO - 2016-11-28 04:29:55.380 screenresolution[1657:10268] starting screenresolution argv=screenresolution get 04:29:55 INFO - 2016-11-28 04:29:55.382 screenresolution[1657:10268] Display 0: 1600x1200x32@60 04:29:55 INFO - 2016-11-28 04:29:55.389 screenresolution[1658:10271] starting screenresolution argv=screenresolution list 04:29:55 INFO - Available Modes on Display 0 04:29:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:29:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:29:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:29:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:29:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:29:55 INFO - Intel Iris: 04:29:55 INFO - Chipset Model: Intel Iris 04:29:55 INFO - Type: GPU 04:29:55 INFO - Bus: Built-In 04:29:55 INFO - VRAM (Dynamic, Max): 1536 MB 04:29:55 INFO - Vendor: Intel (0x8086) 04:29:55 INFO - Device ID: 0x0a2e 04:29:55 INFO - Revision ID: 0x0009 04:29:55 INFO - Displays: 04:29:55 INFO - Display: 04:29:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:29:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:29:55 INFO - Display Serial Number: 1600x1200 60 04:29:55 INFO - Main Display: Yes 04:29:55 INFO - Mirror: Off 04:29:55 INFO - Online: Yes 04:29:55 INFO - Rotation: Supported 04:29:55 INFO - Return code: 0 04:29:55 INFO - Running post-action listener: _resource_record_post_action 04:29:55 INFO - [mozharness: 2016-11-28 12:29:55.635247Z] Finished run-tests step (success) 04:29:55 INFO - Running post-run listener: _resource_record_post_run 04:29:55 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 32152576; Write bytes: 691386880; Read time: 193; Write time: 1989 04:29:55 INFO - TinderboxPrint: CPU usage
53.7% 04:29:55 INFO - TinderboxPrint: I/O read bytes / time
32,152,576 / 193 04:29:55 INFO - TinderboxPrint: I/O write bytes / time
691,386,880 / 1,989 04:29:55 INFO - TinderboxPrint: CPU idle
2,251.4 (46.3%) 04:29:55 INFO - TinderboxPrint: CPU system
973.6 (20.0%) 04:29:55 INFO - TinderboxPrint: CPU user
1,636.7 (33.7%) 04:29:55 INFO - TinderboxPrint: Swap in / out
411,357,184 / 0 04:29:55 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 380776960; Write bytes: 375068160; Read time: 29269; Write time: 811 04:29:55 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 29051904; Write bytes: 303846400; Read time: 172; Write time: 1142 04:29:56 INFO - Running post-run listener: _upload_blobber_files 04:29:56 INFO - Blob upload gear active. 04:29:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:29:56 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 04:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:29:56 INFO - (blobuploader) - INFO - Open directory for files ... 04:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:57 INFO - (blobuploader) - INFO - Done attempting. 04:29:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:29:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:29:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:58 INFO - (blobuploader) - INFO - Done attempting. 04:29:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:29:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:30:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:00 INFO - (blobuploader) - INFO - Done attempting. 04:30:00 INFO - (blobuploader) - INFO - Iteration through files over. 04:30:00 INFO - Return code: 0 04:30:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:30:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:30:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/4e63c901c9f6cad1c8bc6da2699490ecac592b626bbe8dc7ea917892fc9fc1bd176a2f3ea4fc6aed492bb92a087adeca9ff7959cf5d19ee429c86ed8c3bfcbe4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/60c96315fef99f0bd45d189a04e4d381b69081581217cd7d083a436f0c36b441445ab8c9b99b9a34d48e6c75e9f650a8095fb613de5da5eb32473f10e687e397", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/615f2ba87bac413c615f216ea2e9148f9de3d070aded42565f6294f6d54a528a83a5d95494e2a0064c8c0cce85cb1d2a096a5abc7e0694e520e71ba35bfb7d58"} 04:30:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:30:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:30:00 INFO - Contents: 04:30:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/4e63c901c9f6cad1c8bc6da2699490ecac592b626bbe8dc7ea917892fc9fc1bd176a2f3ea4fc6aed492bb92a087adeca9ff7959cf5d19ee429c86ed8c3bfcbe4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/60c96315fef99f0bd45d189a04e4d381b69081581217cd7d083a436f0c36b441445ab8c9b99b9a34d48e6c75e9f650a8095fb613de5da5eb32473f10e687e397", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/615f2ba87bac413c615f216ea2e9148f9de3d070aded42565f6294f6d54a528a83a5d95494e2a0064c8c0cce85cb1d2a096a5abc7e0694e520e71ba35bfb7d58"} 04:30:00 INFO - Running post-run listener: copy_logs_to_upload_dir 04:30:00 INFO - Copying logs to upload dir... 04:30:00 INFO - mkdir: /builds/slave/test/build/upload/logs 04:30:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.477920 ========= master_lag: 1.58 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-28 04:30:02.501639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 04:30:02.509379) ========= 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.Z645NA5red/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.FRgK30UvBr/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/4e63c901c9f6cad1c8bc6da2699490ecac592b626bbe8dc7ea917892fc9fc1bd176a2f3ea4fc6aed492bb92a087adeca9ff7959cf5d19ee429c86ed8c3bfcbe4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/60c96315fef99f0bd45d189a04e4d381b69081581217cd7d083a436f0c36b441445ab8c9b99b9a34d48e6c75e9f650a8095fb613de5da5eb32473f10e687e397", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/615f2ba87bac413c615f216ea2e9148f9de3d070aded42565f6294f6d54a528a83a5d95494e2a0064c8c0cce85cb1d2a096a5abc7e0694e520e71ba35bfb7d58"} build_url:https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/DOn0jx6UTw-6iLy0dlKSSA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/4e63c901c9f6cad1c8bc6da2699490ecac592b626bbe8dc7ea917892fc9fc1bd176a2f3ea4fc6aed492bb92a087adeca9ff7959cf5d19ee429c86ed8c3bfcbe4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/60c96315fef99f0bd45d189a04e4d381b69081581217cd7d083a436f0c36b441445ab8c9b99b9a34d48e6c75e9f650a8095fb613de5da5eb32473f10e687e397", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/615f2ba87bac413c615f216ea2e9148f9de3d070aded42565f6294f6d54a528a83a5d95494e2a0064c8c0cce85cb1d2a096a5abc7e0694e520e71ba35bfb7d58"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 04:30:02.546321) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 04:30:02.546642) ========= 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.Z645NA5red/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.FRgK30UvBr/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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.005153 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 04:30:02.599730) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 04:30:02.604221) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 04:30:02.604656) ========= ========= Total master_lag: 1.76 =========