builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0251 starttime: 1476197205.15 results: success (0) buildid: 20161011055146 builduid: 94fc436fdc7b4ddea0c384cb8b5440f1 revision: 927bfc865b55d9d7f94df43f13cc725f555d580e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 07:46:45.148140) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 07:46:45.153165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 07:46:45.153455) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 07:46:45.265387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:46:45.265797) ========= 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.9jiAGRjQNx/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.abZGV9wWF3/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-11 07:46:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 184M=0s 2016-10-11 07:46:45 (184 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175472 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:46:45.464138) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:46:45.464453) ========= 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.9jiAGRjQNx/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.abZGV9wWF3/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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.027730 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:46:45.516786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-11 07:46:45.517139) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 927bfc865b55d9d7f94df43f13cc725f555d580e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 927bfc865b55d9d7f94df43f13cc725f555d580e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9jiAGRjQNx/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.abZGV9wWF3/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-11 07:46:45,601 truncating revision to first 12 chars 2016-10-11 07:46:45,601 Setting DEBUG logging. 2016-10-11 07:46:45,601 attempt 1/10 2016-10-11 07:46:45,601 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/927bfc865b55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 07:46:47,714 unpacking tar archive at: autoland-927bfc865b55/testing/mozharness/ program finished with exit code 0 elapsedTime=2.379546 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-11 07:46:47.917517) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 07:46:47.917850) ========= script_repo_revision: 927bfc865b55d9d7f94df43f13cc725f555d580e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 07:46:47.918260) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 07:46:47.918533) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 07:46:47.934870) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-11 07:46:47.935279) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9jiAGRjQNx/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.abZGV9wWF3/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:46:48 INFO - MultiFileLogger online at 20161011 07:46:48 in /builds/slave/test 07:46:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 07:46:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:46:48 INFO - {'append_to_log': False, 07:46:48 INFO - 'base_work_dir': '/builds/slave/test', 07:46:48 INFO - 'blob_upload_branch': 'Autoland', 07:46:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:46:48 INFO - 'branch': 'Autoland', 07:46:48 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:48 INFO - 'config_files': ('talos/mac_config.py',), 07:46:48 INFO - 'default_actions': ('clobber', 07:46:48 INFO - 'read-buildbot-config', 07:46:48 INFO - 'download-and-extract', 07:46:48 INFO - 'populate-webroot', 07:46:48 INFO - 'create-virtualenv', 07:46:48 INFO - 'install', 07:46:48 INFO - 'run-tests'), 07:46:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:48 INFO - 'download_minidump_stackwalk': True, 07:46:48 INFO - 'download_symbols': 'ondemand', 07:46:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:46:48 INFO - 'tooltool.py': '/tools/tooltool.py', 07:46:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:46:48 INFO - '/tools/misc-python/virtualenv.py')}, 07:46:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:48 INFO - 'installer_path': 'installer.exe', 07:46:48 INFO - 'log_level': 'info', 07:46:48 INFO - 'log_name': 'talos', 07:46:48 INFO - 'log_to_console': True, 07:46:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:46:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:46:48 INFO - 'opt_config_files': (), 07:46:48 INFO - 'pip_index': False, 07:46:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:48 INFO - 'cmd': ('bash', 07:46:48 INFO - '-c', 07:46:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:48 INFO - 'enabled': True, 07:46:48 INFO - 'halt_on_failure': False, 07:46:48 INFO - 'name': 'check_screen_resolution'},), 07:46:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:48 INFO - 'cmd': ('bash', 07:46:48 INFO - '-c', 07:46:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:48 INFO - 'enabled': True, 07:46:48 INFO - 'halt_on_failure': False, 07:46:48 INFO - 'name': 'check_screen_resolution'},), 07:46:48 INFO - 'run_cmd_checks_enabled': True, 07:46:48 INFO - 'sps_profile': False, 07:46:48 INFO - 'sps_profile_interval': 0, 07:46:48 INFO - 'suite': 'dromaeojs', 07:46:48 INFO - 'system_bits': '32', 07:46:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:48 INFO - 'title': 't-yosemite-r7-0251', 07:46:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:48 INFO - 'use_talos_json': True, 07:46:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:46:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:48 INFO - 'work_dir': 'build'} 07:46:48 INFO - [mozharness: 2016-10-11 14:46:48.135450Z] Running clobber step. 07:46:48 INFO - Running pre-action listener: _resource_record_pre_action 07:46:48 INFO - Running main action method: clobber 07:46:48 INFO - rmtree: /builds/slave/test/build 07:46:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:50 INFO - Running post-action listener: _resource_record_post_action 07:46:50 INFO - [mozharness: 2016-10-11 14:46:50.378208Z] Finished clobber step (success) 07:46:50 INFO - [mozharness: 2016-10-11 14:46:50.378445Z] Running read-buildbot-config step. 07:46:50 INFO - Running pre-action listener: _resource_record_pre_action 07:46:50 INFO - Running main action method: read_buildbot_config 07:46:50 INFO - Using buildbot properties: 07:46:50 INFO - { 07:46:50 INFO - "project": "", 07:46:50 INFO - "product": "firefox", 07:46:50 INFO - "script_repo_revision": "production", 07:46:50 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 07:46:50 INFO - "repository": "", 07:46:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 07:46:50 INFO - "buildid": "20161011055146", 07:46:50 INFO - "pgo_build": "False", 07:46:50 INFO - "basedir": "/builds/slave/test", 07:46:50 INFO - "buildnumber": 253, 07:46:50 INFO - "slavename": "t-yosemite-r7-0251", 07:46:50 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:46:50 INFO - "platform": "yosemite_r7", 07:46:50 INFO - "scheduler": "tests-autoland-macosx64-talos", 07:46:50 INFO - "branch": "autoland", 07:46:50 INFO - "repo_path": "integration/autoland", 07:46:50 INFO - "revision": "927bfc865b55d9d7f94df43f13cc725f555d580e", 07:46:50 INFO - "stage_platform": "macosx64", 07:46:50 INFO - "builduid": "94fc436fdc7b4ddea0c384cb8b5440f1", 07:46:50 INFO - "slavebuilddir": "test" 07:46:50 INFO - } 07:46:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 07:46:50 INFO - Running post-action listener: _resource_record_post_action 07:46:50 INFO - [mozharness: 2016-10-11 14:46:50.384009Z] Finished read-buildbot-config step (success) 07:46:50 INFO - [mozharness: 2016-10-11 14:46:50.384233Z] Running download-and-extract step. 07:46:50 INFO - Running pre-action listener: _resource_record_pre_action 07:46:50 INFO - Running main action method: download_and_extract 07:46:50 INFO - mkdir: /builds/slave/test/build/tests 07:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:50 INFO - trying https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 07:46:50 INFO - Downloading https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 07:46:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 07:46:51 INFO - Downloaded 1199 bytes. 07:46:51 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 07:46:51 INFO - Using the following test package requirements: 07:46:51 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 07:46:51 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:51 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 07:46:51 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:51 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 07:46:51 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:51 INFO - u'jsshell-mac.zip'], 07:46:51 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:51 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 07:46:51 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 07:46:51 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:51 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 07:46:51 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:51 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 07:46:51 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:51 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 07:46:51 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:51 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 07:46:51 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:46:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 07:46:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:46:51 INFO - Fetch https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 07:46:52 INFO - Http code: 200 07:46:52 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 07:46:52 INFO - x-amz-cf-id: x5ZrfLEocAz1YGX5vpMbygdKd2wQSDwtdGWW5QtqQ0vJe7SJqjsR2A== 07:46:52 INFO - x-amz-version-id: SbQCRXSKu3SZgFJIzOtBK6I6QrqGe.u5 07:46:52 INFO - Expected file size: 16508479 07:46:52 INFO - Obtained file size: 16508479 07:46:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:46:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 07:46:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:46:59 INFO - Fetch https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 07:46:59 INFO - Http code: 200 07:46:59 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 07:46:59 INFO - x-amz-cf-id: CXK4c7KzDLgyji55fM9ZJkzVh2Y59Y8EGfs0XxQcg8jAO599PTFw4Q== 07:46:59 INFO - x-amz-version-id: SbQCRXSKu3SZgFJIzOtBK6I6QrqGe.u5 07:47:00 INFO - Expected file size: 16508479 07:47:00 INFO - Obtained file size: 16508479 07:47:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 07:47:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:47:06 INFO - Fetch https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 07:47:07 INFO - Http code: 200 07:47:07 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 07:47:07 INFO - x-amz-cf-id: Q8hUUg_QreUiq9H5fo4cim75vwL81SGsVd0lI2MUqz5toVGc-TGd3w== 07:47:07 INFO - x-amz-version-id: gfYdm.BgANU0f3tZOrFu.6YCOhf80Yso 07:47:08 INFO - Expected file size: 14409006 07:47:08 INFO - Obtained file size: 14409006 07:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:08 INFO - trying https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:47:08 INFO - Downloading https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 07:47:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 07:47:11 INFO - Downloaded 111692567 bytes. 07:47:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:47:11 INFO - mkdir: /builds/slave/test/properties 07:47:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:47:11 INFO - Writing to file /builds/slave/test/properties/build_url 07:47:11 INFO - Contents: 07:47:11 INFO - build_url:https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:47:12 INFO - Running post-action listener: _resource_record_post_action 07:47:12 INFO - Running post-action listener: set_extra_try_arguments 07:47:12 INFO - [mozharness: 2016-10-11 14:47:12.060086Z] Finished download-and-extract step (success) 07:47:12 INFO - [mozharness: 2016-10-11 14:47:12.060244Z] Running populate-webroot step. 07:47:12 INFO - Running pre-action listener: _resource_record_pre_action 07:47:12 INFO - Running main action method: populate_webroot 07:47:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:47:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:47:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:47:12 INFO - '--tppagecycles', 07:47:12 INFO - '7'], 07:47:12 INFO - 'tests': ['tsvgm']}}, 07:47:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:47:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:47:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:47:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:47:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:47:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:47:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:12 INFO - 'talos_options': ['--disable-e10s'], 07:47:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:12 INFO - 'talos_options': ['--disable-e10s'], 07:47:12 INFO - 'tests': ['damp', 'tps']}, 07:47:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:12 INFO - 'tests': ['damp', 'tps']}, 07:47:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:47:12 INFO - 'tests': ['dromaeo_dom']}, 07:47:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:47:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:47:12 INFO - 'tests': ['basic_compositor_video']}, 07:47:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:47:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:47:12 INFO - 'tests': ['a11yr', 07:47:12 INFO - 'ts_paint', 07:47:12 INFO - 'tpaint', 07:47:12 INFO - 'sessionrestore', 07:47:12 INFO - 'sessionrestore_no_auto_restore', 07:47:12 INFO - 'tabpaint']}, 07:47:12 INFO - 'other-e10s': {'tests': ['a11yr', 07:47:12 INFO - 'ts_paint', 07:47:12 INFO - 'tpaint', 07:47:12 INFO - 'sessionrestore', 07:47:12 INFO - 'sessionrestore_no_auto_restore', 07:47:12 INFO - 'tabpaint']}, 07:47:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:47:12 INFO - 'ts_paint', 07:47:12 INFO - 'tpaint', 07:47:12 INFO - 'sessionrestore', 07:47:12 INFO - 'sessionrestore_no_auto_restore', 07:47:12 INFO - 'tabpaint']}, 07:47:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:47:12 INFO - 'ts_paint', 07:47:12 INFO - 'tpaint', 07:47:12 INFO - 'sessionrestore', 07:47:12 INFO - 'sessionrestore_no_auto_restore', 07:47:12 INFO - 'tabpaint']}, 07:47:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:47:12 INFO - 'tests': ['a11yr', 07:47:12 INFO - 'ts_paint', 07:47:12 INFO - 'tpaint', 07:47:12 INFO - 'sessionrestore', 07:47:12 INFO - 'sessionrestore_no_auto_restore', 07:47:12 INFO - 'tabpaint']}, 07:47:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:47:12 INFO - 'tests': ['a11yr', 07:47:12 INFO - 'ts_paint', 07:47:12 INFO - 'tpaint', 07:47:12 INFO - 'sessionrestore', 07:47:12 INFO - 'sessionrestore_no_auto_restore', 07:47:12 INFO - 'tabpaint']}, 07:47:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:47:12 INFO - 'tests': ['tsvgx', 07:47:12 INFO - 'tsvgr_opacity', 07:47:12 INFO - 'tart', 07:47:12 INFO - 'tscrollx', 07:47:12 INFO - 'cart']}, 07:47:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:47:12 INFO - 'tsvgr_opacity', 07:47:12 INFO - 'tart', 07:47:12 INFO - 'tscrollx', 07:47:12 INFO - 'cart']}, 07:47:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:12 INFO - 'talos_options': ['--disable-e10s'], 07:47:12 INFO - 'tests': ['tp5o']}, 07:47:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:12 INFO - 'tests': ['tp5o']}, 07:47:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:12 INFO - 'talos_options': ['--disable-e10s', 07:47:12 INFO - '--xperf_path', 07:47:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:12 INFO - 'tests': ['tp5n']}, 07:47:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:12 INFO - 'talos_options': ['--xperf_path', 07:47:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:12 INFO - 'tests': ['tp5n']}}, 07:47:12 INFO - 'talos.zip': {'path': '', 07:47:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:47:12 INFO - Running post-action listener: _resource_record_post_action 07:47:12 INFO - [mozharness: 2016-10-11 14:47:12.079181Z] Finished populate-webroot step (success) 07:47:12 INFO - [mozharness: 2016-10-11 14:47:12.079281Z] Running create-virtualenv step. 07:47:12 INFO - Running pre-action listener: _resource_record_pre_action 07:47:12 INFO - Running main action method: create_virtualenv 07:47:12 INFO - Creating virtualenv /builds/slave/test/build/venv 07:47:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:47:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:47:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:47:12 INFO - Using real prefix '/tools/python27' 07:47:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:47:12 INFO - Installing distribute.............................................................................................................................................................................................done. 07:47:15 INFO - Installing pip.................done. 07:47:15 INFO - Return code: 0 07:47:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:47:16 INFO - Reading from file tmpfile_stdout 07:47:16 INFO - Output received: 07:47:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:47:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c51f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c495570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad63b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c333d30>, '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 0x10c159db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bb20>, '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.9jiAGRjQNx/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.abZGV9wWF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47: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', 'pip>=1.5'] in /builds/slave/test/build 07:47: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 pip>=1.5 07:47:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9jiAGRjQNx/Render', 07:47:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:16 INFO - 'HOME': '/Users/cltbld', 07:47:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:16 INFO - 'LOGNAME': 'cltbld', 07:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:16 INFO - 'MOZ_NO_REMOTE': '1', 07:47:16 INFO - 'NO_EM_RESTART': '1', 07:47:16 INFO - 'PAGER': '/bin/cat', 07:47:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:16 INFO - 'PWD': '/builds/slave/test', 07:47:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:16 INFO - 'SHELL': '/bin/bash', 07:47:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abZGV9wWF3/Listeners', 07:47:16 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 07:47:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:16 INFO - 'USER': 'cltbld', 07:47:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:16 INFO - 'XPC_FLAGS': '0x0', 07:47:16 INFO - 'XPC_SERVICE_NAME': '0', 07:47:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:47:16 INFO - Cleaning up... 07:47:16 INFO - Return code: 0 07:47:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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', '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 0x10c51f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c495570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad63b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c333d30>, '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 0x10c159db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bb20>, '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.9jiAGRjQNx/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.abZGV9wWF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:47: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 psutil>=3.1.1 07:47:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9jiAGRjQNx/Render', 07:47:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:16 INFO - 'HOME': '/Users/cltbld', 07:47:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:16 INFO - 'LOGNAME': 'cltbld', 07:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:16 INFO - 'MOZ_NO_REMOTE': '1', 07:47:16 INFO - 'NO_EM_RESTART': '1', 07:47:16 INFO - 'PAGER': '/bin/cat', 07:47:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:16 INFO - 'PWD': '/builds/slave/test', 07:47:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:16 INFO - 'SHELL': '/bin/bash', 07:47:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abZGV9wWF3/Listeners', 07:47:16 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 07:47:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:16 INFO - 'USER': 'cltbld', 07:47:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:16 INFO - 'XPC_FLAGS': '0x0', 07:47:16 INFO - 'XPC_SERVICE_NAME': '0', 07:47:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:16 INFO - Downloading/unpacking psutil>=3.1.1 07:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:47:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:20 INFO - Installing collected packages: psutil 07:47:20 INFO - Running setup.py install for psutil 07:47:20 INFO - building 'psutil._psutil_osx' extension 07:47:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:47:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:47:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:47:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:47:21 INFO - building 'psutil._psutil_posix' extension 07:47:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:47:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:47:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:47:21 INFO - ^ 07:47:21 INFO - 1 warning generated. 07:47:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:47:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:21 INFO - Successfully installed psutil 07:47:21 INFO - Cleaning up... 07:47:21 INFO - Return code: 0 07:47:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c51f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c495570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad63b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c333d30>, '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 0x10c159db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bb20>, '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.9jiAGRjQNx/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.abZGV9wWF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:47:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9jiAGRjQNx/Render', 07:47:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:21 INFO - 'HOME': '/Users/cltbld', 07:47:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:21 INFO - 'LOGNAME': 'cltbld', 07:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:21 INFO - 'MOZ_NO_REMOTE': '1', 07:47:21 INFO - 'NO_EM_RESTART': '1', 07:47:21 INFO - 'PAGER': '/bin/cat', 07:47:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:21 INFO - 'PWD': '/builds/slave/test', 07:47:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:21 INFO - 'SHELL': '/bin/bash', 07:47:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abZGV9wWF3/Listeners', 07:47:21 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 07:47:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:21 INFO - 'USER': 'cltbld', 07:47:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:21 INFO - 'XPC_FLAGS': '0x0', 07:47:21 INFO - 'XPC_SERVICE_NAME': '0', 07:47:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:47:24 INFO - Installing collected packages: mozsystemmonitor 07:47:24 INFO - Running setup.py install for mozsystemmonitor 07:47:24 INFO - Successfully installed mozsystemmonitor 07:47:24 INFO - Cleaning up... 07:47:24 INFO - Return code: 0 07:47:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:24 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 0x10c51f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c495570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad63b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c333d30>, '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 0x10c159db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bb20>, '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.9jiAGRjQNx/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.abZGV9wWF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9jiAGRjQNx/Render', 07:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:24 INFO - 'HOME': '/Users/cltbld', 07:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:24 INFO - 'LOGNAME': 'cltbld', 07:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:24 INFO - 'MOZ_NO_REMOTE': '1', 07:47:24 INFO - 'NO_EM_RESTART': '1', 07:47:24 INFO - 'PAGER': '/bin/cat', 07:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:24 INFO - 'PWD': '/builds/slave/test', 07:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:24 INFO - 'SHELL': '/bin/bash', 07:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abZGV9wWF3/Listeners', 07:47:24 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 07:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:24 INFO - 'USER': 'cltbld', 07:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:24 INFO - 'XPC_FLAGS': '0x0', 07:47:24 INFO - 'XPC_SERVICE_NAME': '0', 07:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:47:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47:28 INFO - Downloading functools32-3.2.3-2.tar.gz 07:47:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:47:28 INFO - warning: no files found matching '*.txt' 07:47:28 INFO - no previously-included directories found matching 'build' 07:47:28 INFO - no previously-included directories found matching 'dist' 07:47:28 INFO - no previously-included directories found matching '.git*' 07:47:28 INFO - Installing collected packages: jsonschema, functools32 07:47:28 INFO - Running setup.py install for functools32 07:47:28 INFO - warning: no files found matching '*.txt' 07:47:28 INFO - no previously-included directories found matching 'build' 07:47:28 INFO - no previously-included directories found matching 'dist' 07:47:28 INFO - no previously-included directories found matching '.git*' 07:47:28 INFO - Successfully installed jsonschema functools32 07:47:28 INFO - Cleaning up... 07:47:28 INFO - Return code: 0 07:47:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:28 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 0x10c51f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c495570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad63b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c333d30>, '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 0x10c159db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bb20>, '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.9jiAGRjQNx/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.abZGV9wWF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:47:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9jiAGRjQNx/Render', 07:47:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:28 INFO - 'HOME': '/Users/cltbld', 07:47:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:28 INFO - 'LOGNAME': 'cltbld', 07:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:28 INFO - 'MOZ_NO_REMOTE': '1', 07:47:28 INFO - 'NO_EM_RESTART': '1', 07:47:28 INFO - 'PAGER': '/bin/cat', 07:47:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:28 INFO - 'PWD': '/builds/slave/test', 07:47:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:28 INFO - 'SHELL': '/bin/bash', 07:47:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abZGV9wWF3/Listeners', 07:47:28 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 07:47:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:28 INFO - 'USER': 'cltbld', 07:47:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:28 INFO - 'XPC_FLAGS': '0x0', 07:47:28 INFO - 'XPC_SERVICE_NAME': '0', 07:47:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:47:28 INFO - Cleaning up... 07:47:28 INFO - Return code: 0 07:47:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:28 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 0x10c51f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c495570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad63b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c333d30>, '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 0x10c159db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bb20>, '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.9jiAGRjQNx/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.abZGV9wWF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:47:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9jiAGRjQNx/Render', 07:47:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:28 INFO - 'HOME': '/Users/cltbld', 07:47:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:28 INFO - 'LOGNAME': 'cltbld', 07:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:28 INFO - 'MOZ_NO_REMOTE': '1', 07:47:28 INFO - 'NO_EM_RESTART': '1', 07:47:28 INFO - 'PAGER': '/bin/cat', 07:47:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:28 INFO - 'PWD': '/builds/slave/test', 07:47:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:28 INFO - 'SHELL': '/bin/bash', 07:47:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abZGV9wWF3/Listeners', 07:47:28 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 07:47:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:28 INFO - 'USER': 'cltbld', 07:47:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:28 INFO - 'XPC_FLAGS': '0x0', 07:47:28 INFO - 'XPC_SERVICE_NAME': '0', 07:47:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:29 INFO - Downloading/unpacking blobuploader==1.2.4 07:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:47:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:47:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:47:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:32 INFO - Downloading docopt-0.6.1.tar.gz 07:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:47:32 INFO - Installing collected packages: blobuploader, requests, docopt 07:47:32 INFO - Running setup.py install for blobuploader 07:47:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:47:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:47:33 INFO - Running setup.py install for requests 07:47:33 INFO - Running setup.py install for docopt 07:47:33 INFO - Successfully installed blobuploader requests docopt 07:47:33 INFO - Cleaning up... 07:47:33 INFO - Return code: 0 07:47:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:33 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 0x10c51f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c495570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad63b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c333d30>, '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 0x10c159db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bb20>, '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.9jiAGRjQNx/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.abZGV9wWF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9jiAGRjQNx/Render', 07:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:33 INFO - 'HOME': '/Users/cltbld', 07:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:33 INFO - 'LOGNAME': 'cltbld', 07:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:33 INFO - 'MOZ_NO_REMOTE': '1', 07:47:33 INFO - 'NO_EM_RESTART': '1', 07:47:33 INFO - 'PAGER': '/bin/cat', 07:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:33 INFO - 'PWD': '/builds/slave/test', 07:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:33 INFO - 'SHELL': '/bin/bash', 07:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abZGV9wWF3/Listeners', 07:47:33 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 07:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:33 INFO - 'USER': 'cltbld', 07:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:33 INFO - 'XPC_FLAGS': '0x0', 07:47:33 INFO - 'XPC_SERVICE_NAME': '0', 07:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-ugLypF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-mYp84h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-OS1vww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-4wIpoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-Jp9ElV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-cQkTo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-fePu7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-V_Wxxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:34 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-RAA2C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-Nxabnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-NRWklq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-Ig6n5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-XkJdcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-TmFKqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-_36_00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-PJSsGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:35 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-ygXRn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:47:35 INFO - Running setup.py install for manifestparser 07:47:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:47:36 INFO - Running setup.py install for mozcrash 07:47:36 INFO - Running setup.py install for mozdebug 07:47:36 INFO - Running setup.py install for mozdevice 07:47:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:47:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:47:36 INFO - Running setup.py install for mozfile 07:47:36 INFO - Running setup.py install for mozhttpd 07:47:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:47:36 INFO - Running setup.py install for mozinfo 07:47:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:47:36 INFO - Running setup.py install for mozInstall 07:47:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Running setup.py install for mozleak 07:47:37 INFO - Running setup.py install for mozlog 07:47:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Running setup.py install for moznetwork 07:47:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Running setup.py install for mozprocess 07:47:37 INFO - Running setup.py install for mozprofile 07:47:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:47:37 INFO - Running setup.py install for mozrunner 07:47:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:47:38 INFO - Running setup.py install for mozscreenshot 07:47:38 INFO - Running setup.py install for moztest 07:47:38 INFO - Running setup.py install for mozversion 07:47:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:47:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:47:38 INFO - Cleaning up... 07:47:38 INFO - Return code: 0 07:47:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:38 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 0x10c51f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c495570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad63b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c333d30>, '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 0x10c159db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bb20>, '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.9jiAGRjQNx/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.abZGV9wWF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:47:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9jiAGRjQNx/Render', 07:47:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:38 INFO - 'HOME': '/Users/cltbld', 07:47:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:38 INFO - 'LOGNAME': 'cltbld', 07:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:38 INFO - 'MOZ_NO_REMOTE': '1', 07:47:38 INFO - 'NO_EM_RESTART': '1', 07:47:38 INFO - 'PAGER': '/bin/cat', 07:47:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:38 INFO - 'PWD': '/builds/slave/test', 07:47:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:38 INFO - 'SHELL': '/bin/bash', 07:47:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abZGV9wWF3/Listeners', 07:47:38 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 07:47:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:38 INFO - 'USER': 'cltbld', 07:47:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:38 INFO - 'XPC_FLAGS': '0x0', 07:47:38 INFO - 'XPC_SERVICE_NAME': '0', 07:47:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:38 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-8atfIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:38 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-_QZojg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:38 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-aXsUIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-mpZT5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-w2vq3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-jQngKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-egNEOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-8sG4Gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-f7EU3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-_hBrL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-rkFjyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:39 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-b6IV7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-4GGTyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-z4FSFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-1nIdOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-9k3mwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:40 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-LcwJf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:47:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:43 INFO - Downloading blessings-1.6.tar.gz 07:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:47:43 INFO - Installing collected packages: blessings 07:47:43 INFO - Running setup.py install for blessings 07:47:43 INFO - Successfully installed blessings 07:47:43 INFO - Cleaning up... 07:47:43 INFO - Return code: 0 07:47:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:47:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:43 INFO - Reading from file tmpfile_stdout 07:47:43 INFO - Current package versions: 07:47:43 INFO - blessings == 1.6 07:47:43 INFO - blobuploader == 1.2.4 07:47:43 INFO - docopt == 0.6.1 07:47:43 INFO - functools32 == 3.2.3-2 07:47:43 INFO - jsonschema == 2.5.1 07:47:43 INFO - manifestparser == 1.1 07:47:43 INFO - mozInstall == 1.12 07:47:43 INFO - mozcrash == 0.17 07:47:43 INFO - mozdebug == 0.1 07:47:43 INFO - mozdevice == 0.48 07:47:43 INFO - mozfile == 1.2 07:47:43 INFO - mozhttpd == 0.7 07:47:43 INFO - mozinfo == 0.9 07:47:43 INFO - mozleak == 0.1 07:47:43 INFO - mozlog == 3.4 07:47:43 INFO - moznetwork == 0.27 07:47:43 INFO - mozprocess == 0.23 07:47:43 INFO - mozprofile == 0.28 07:47:43 INFO - mozrunner == 6.12 07:47:43 INFO - mozscreenshot == 0.1 07:47:43 INFO - mozsystemmonitor == 0.3 07:47:43 INFO - moztest == 0.7 07:47:43 INFO - mozversion == 1.4 07:47:43 INFO - psutil == 3.1.1 07:47:43 INFO - requests == 1.2.3 07:47:43 INFO - wsgiref == 0.1.2 07:47:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:43 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 0x10c51f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c495570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad63b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c333d30>, '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 0x10c159db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bb20>, '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.9jiAGRjQNx/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.abZGV9wWF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:47:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9jiAGRjQNx/Render', 07:47:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:43 INFO - 'HOME': '/Users/cltbld', 07:47:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:43 INFO - 'LOGNAME': 'cltbld', 07:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:43 INFO - 'MOZ_NO_REMOTE': '1', 07:47:43 INFO - 'NO_EM_RESTART': '1', 07:47:43 INFO - 'PAGER': '/bin/cat', 07:47:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:43 INFO - 'PWD': '/builds/slave/test', 07:47:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:43 INFO - 'SHELL': '/bin/bash', 07:47:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abZGV9wWF3/Listeners', 07:47:43 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 07:47:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:43 INFO - 'USER': 'cltbld', 07:47:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:43 INFO - 'XPC_FLAGS': '0x0', 07:47:43 INFO - 'XPC_SERVICE_NAME': '0', 07:47:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:47:44 INFO - Cleaning up... 07:47:44 INFO - Return code: 0 07:47:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c51f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c495570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad63b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c333d30>, '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 0x10c159db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bb20>, '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.9jiAGRjQNx/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.abZGV9wWF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:47:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9jiAGRjQNx/Render', 07:47:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:44 INFO - 'HOME': '/Users/cltbld', 07:47:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:44 INFO - 'LOGNAME': 'cltbld', 07:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:44 INFO - 'MOZ_NO_REMOTE': '1', 07:47:44 INFO - 'NO_EM_RESTART': '1', 07:47:44 INFO - 'PAGER': '/bin/cat', 07:47:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:44 INFO - 'PWD': '/builds/slave/test', 07:47:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:44 INFO - 'SHELL': '/bin/bash', 07:47:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abZGV9wWF3/Listeners', 07:47:44 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 07:47:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:44 INFO - 'USER': 'cltbld', 07:47:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:44 INFO - 'XPC_FLAGS': '0x0', 07:47:44 INFO - 'XPC_SERVICE_NAME': '0', 07:47:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:47:44 INFO - Cleaning up... 07:47:44 INFO - Return code: 0 07:47:44 INFO - Running post-action listener: _resource_record_post_action 07:47:44 INFO - Running post-action listener: _start_resource_monitoring 07:47:44 INFO - Starting resource monitoring. 07:47:44 INFO - [mozharness: 2016-10-11 14:47:44.330882Z] Finished create-virtualenv step (success) 07:47:44 INFO - [mozharness: 2016-10-11 14:47:44.331877Z] Running install step. 07:47:44 INFO - Running pre-action listener: _resource_record_pre_action 07:47:44 INFO - Running main action method: install 07:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:44 INFO - Reading from file tmpfile_stdout 07:47:44 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:44 INFO - Reading from file tmpfile_stdout 07:47:44 INFO - Output received: 07:47:44 INFO - Usage: mozinstall [options] installer 07:47:44 INFO - Options: 07:47:44 INFO - -h, --help show this help message and exit 07:47:44 INFO - -d DEST, --destination=DEST 07:47:44 INFO - Directory to install application into. [default: 07:47:44 INFO - "/builds/slave/test"] 07:47:44 INFO - --app=APP Application being installed. [default: firefox] 07:47:44 INFO - mkdir: /builds/slave/test/build/application 07:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:48:19 INFO - Reading from file tmpfile_stdout 07:48:19 INFO - Output received: 07:48:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:48:19 INFO - Running post-action listener: _resource_record_post_action 07:48:19 INFO - [mozharness: 2016-10-11 14:48:19.398989Z] Finished install step (success) 07:48:19 INFO - [mozharness: 2016-10-11 14:48:19.399133Z] Running run-tests step. 07:48:19 INFO - Running pre-action listener: _resource_record_pre_action 07:48:19 INFO - Running main action method: run_tests 07:48:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:48:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:48:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:48:19 INFO - 2016-10-11 07:48:19.413 screenresolution[1651:8559] starting screenresolution argv=screenresolution get 07:48:19 INFO - 2016-10-11 07:48:19.416 screenresolution[1651:8559] Display 0: 1600x1200x32@60 07:48:19 INFO - 2016-10-11 07:48:19.421 screenresolution[1652:8561] starting screenresolution argv=screenresolution list 07:48:19 INFO - Available Modes on Display 0 07:48:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:48:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:48:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:48:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:48:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:48:19 INFO - Intel Iris: 07:48:19 INFO - Chipset Model: Intel Iris 07:48:19 INFO - Type: GPU 07:48:19 INFO - Bus: Built-In 07:48:19 INFO - VRAM (Dynamic, Max): 1536 MB 07:48:19 INFO - Vendor: Intel (0x8086) 07:48:19 INFO - Device ID: 0x0a2e 07:48:19 INFO - Revision ID: 0x0009 07:48:19 INFO - Displays: 07:48:19 INFO - Display: 07:48:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:48:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:48:19 INFO - Display Serial Number: 1600x1200 60 07:48:19 INFO - Main Display: Yes 07:48:19 INFO - Mirror: Off 07:48:19 INFO - Online: Yes 07:48:19 INFO - Rotation: Supported 07:48:19 INFO - Return code: 0 07:48:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:48:19 INFO - Python 2.7.3 07:48:19 INFO - Return code: 0 07:48:19 INFO - grabbing minidump binary from tooltool 07:48: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')]} 07:48:19 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 0x10c333d30>, '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 0x10c159db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c32bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:48:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:48:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:48:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:48:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:48:19 INFO - Return code: 0 07:48:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:48:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:48:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:48:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:48:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:48:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0251', '--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 07:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0251 --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 07:48:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9jiAGRjQNx/Render', 07:48:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:19 INFO - 'HOME': '/Users/cltbld', 07:48:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:19 INFO - 'LOGNAME': 'cltbld', 07:48:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:48:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:19 INFO - 'MOZ_NO_REMOTE': '1', 07:48:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:48:19 INFO - 'NO_EM_RESTART': '1', 07:48:19 INFO - 'PAGER': '/bin/cat', 07:48:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:19 INFO - 'PWD': '/builds/slave/test', 07:48:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:48:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:19 INFO - 'SHELL': '/bin/bash', 07:48:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.abZGV9wWF3/Listeners', 07:48:19 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 07:48:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:19 INFO - 'USER': 'cltbld', 07:48:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:19 INFO - 'XPC_FLAGS': '0x0', 07:48:19 INFO - 'XPC_SERVICE_NAME': '0', 07:48:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0251', '--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 07:48:20 INFO - mozversion application_buildid: 20161011055146 07:48:20 INFO - mozversion application_changeset: 927bfc865b55d9d7f94df43f13cc725f555d580e 07:48:20 INFO - mozversion application_display_name: Nightly 07:48:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:48:20 INFO - mozversion application_name: Firefox 07:48:20 INFO - mozversion application_remotingname: firefox 07:48:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 07:48:20 INFO - mozversion application_vendor: Mozilla 07:48:20 INFO - mozversion application_version: 52.0a1 07:48:20 INFO - mozversion platform_buildid: 20161011055146 07:48:20 INFO - mozversion platform_changeset: 927bfc865b55d9d7f94df43f13cc725f555d580e 07:48:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 07:48:20 INFO - mozversion platform_version: 52.0a1 07:48:20 INFO - using testdate: 1476197300 07:48:20 INFO - actual date: 1476197300 07:48:20 INFO - starting webserver on 'localhost:49274' 07:48:20 INFO - SUITE-START | Running 2 tests 07:48:20 INFO - TEST-START | dromaeo_css 07:48:20 INFO - operating with platform_type : mac_ 07:48:20 INFO - Initialising browser for dromaeo_css test... 07:48:20 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmpvGbmUY/profile http://localhost:49274/getInfo.html) 07:48:22 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 07:48:22 INFO - PROCESS | 1662 | colorDepth:24 07:48:22 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 07:48:22 INFO - PROCESS | 1662 | __metrics 07:48:22 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:48:22 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:48:23 INFO - TEST-INFO | 1662: exit 0 07:48:23 INFO - Browser initialized. 07:48:23 INFO - Running cycle 1/1 for dromaeo_css test... 07:48:23 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmpvGbmUY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:48:34 INFO - PROCESS | 1665 | RSS: Main: 234573824 07:48:34 INFO - PROCESS | 1665 | 07:49:26 INFO - PROCESS | 1665 | 1476197366367 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:51:38 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 07:51:40 INFO - PROCESS | 1665 | RSS: Main: 407785472 07:51:40 INFO - PROCESS | 1665 | 07:54:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 07:54:43 INFO - PROCESS | 1665 | RSS: Main: 372555776 07:54:43 INFO - PROCESS | 1665 | 07:57:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 07:57:46 INFO - PROCESS | 1665 | RSS: Main: 333443072 07:57:46 INFO - PROCESS | 1665 | 08:00:48 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 08:00:49 INFO - PROCESS | 1665 | RSS: Main: 352534528 08:00:49 INFO - PROCESS | 1665 | 08:03:52 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 08:03:53 INFO - PROCESS | 1665 | RSS: Main: 329113600 08:03:53 INFO - PROCESS | 1665 | 08:06:56 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 08:06:56 INFO - PROCESS | 1665 | RSS: Main: 417415168 08:06:56 INFO - PROCESS | 1665 | 08:06:56 INFO - PROCESS | 1665 | __start_tp_report 08:06:56 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 08:06:56 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 08:06:56 INFO - PROCESS | 1665 | |i|pagename|runs| 08:06:56 INFO - PROCESS | 1665 | |0;dojo.html;3147.826869522176;3334.9333013339733;3340.3653305871876;3342.933141337172;3358.966410335896;5549.861253468665;5577.749001294941;5633.887322253552;5635.549156067515;5683.658980461175;5621.184928185411;5639.295088113986;5650.5479561635075;5650.982823091852;5651.519620832224;5047.419546752125;5108.438071812097;5126.102931986906;5130.974345128269;5147.330846989886;5183.663061900983;5190.584753219733;5218.947810521903;5236.947630523703;5251.081060814361;5232.6075544334135;5241.737913104349;5244.554212891909;5287.682739035651;5305.071612467822;425.32793140930073;5210.7655155517905;5240.868978275574;5252.080885844962;5288.894222115536;3260.703280372404;5099.286099946011;5146.614003949681;5153.768080436389;5231.659942103751;5583;5583.134614134816;5618.185363122365;5639.548836093103;5673.716314184274;5992;6207.6275423474735;6212.9068063979075;6225.688715564249;6231.906521402183;6093.248624977057;6115.449609535119;6146.385361463817;6150.354212807635;6209.233502512713;5698;5709.172170035322;5713.114467257582;5722.885542289131;5772.076467765221;6279.623222606567;6316.9368306317265;6322.209723784527;6322.4942004639515;6340.334264902119;5908.734106965197;5957.255343082114;5963.850903727354;5997.940020599825;6040.818775436744;6156;6191.318954915046;6205.751769929152;6220.25356957159;6239.719212635442;6158.291796443466;6159.938400616026;6163.260408750979;6171.47542458896;6175.783847565313;5977.551683623746;6115.143879856823;6168.321484636686;6169.2288463942;6201.286852011986;4869.196582563837;4895.73073480962;4899.559039686445;4924.556789888928;4947.60419166473;4289.378040184156;4301.333293339538;4333.1766964276685;4390.1878152541885;4475.552444755498;4825.396825396825;5628.212050312959;5644.717764111778;5644.774209031675;5690.487856092972;6071.544634152457;6106.460667180062;6124.632522048602;6131.315499378962;6177.62934223948;5661.009323368394;5696.8860622787315;5716.28546431696;5739.85650358736;5757.6833274169485;5333.413324534298;5349.919751203735;5351.357837059578;5358.91961620576;5361.919571206435;6145.784897528565;6281.905771413341;6291.402316779899;6295.496360291074;6314.715837787218;5197.532222100029;6118.694065296806;6148.538859585638;6163.476104530986;6281;6277.5605707600025;6282.340354262919;6294.716737746904;6297.811065668037;6312.2740884796995;6105.664188469676;6134.938650613615;6139.140520327069;6147.108669243024;6165.568410211242;5117.43708192106;6090.23872015998;6101.450869421773;6106.023036314346;6116.366205733216;5956.583039187215;5966.701664916824;5976.193213916065;5989.490893274121;5997.0404735242155;5900.350961394329;5902.498287645598;5924.52603791687;5938.940610593839;5949.0481522956115;5555.194496797861;5716.371199168005;5726.112452569859;5800.50695690871;5812.94187058141;5983;6091.543134264859;6095.408112664776;6135.325114237341;6138.938610613836;5739.655620662774;5810;5893.6463812171405;5896.321922978912;5900.64596124234 08:06:56 INFO - PROCESS | 1665 | |1;ext.html;479.5803671787185;523.1446584833795;525.3879230696239;525.5007742644488;554.7087778916072;29498.557521637165;29684.10947671568;31092.22269443265;38428.03929901754;39466;40636.18727625453;41111.383329250086;41147.38278925818;41173.17653646933;41224;9350.018248083956;9572.904270957306;9584.233261339112;9587.328886977913;9605.759856003586;9369;9469.763255918588;9483.715488535356;9490;9496.240300775922;7989.480683755566;8039.758807235792;9454.81090378192;9490.050994900525;9490.145886870181;9433.76415589609;9464.905350946507;9489.952550237274;9495.240380769523;9509.667161649379;9363.812723745486;9452.385594936308;9458.52707364629;9462.52687365636;9477.810443791155;38399;38770.83687489352;38782;38800.029999249964;38881.805590972144;3271.1331497153274;3296.3736889990823;3298;3327.234736010707;3956.1494278729924;29308.41383172346;29791.851040744874;30253.848730756425;30419.543706844415;30957.8452107738;3180.9522857157162;3188.856501457417;3190.952135717966;3197.2486465680545;3198.9200269993203;501217;502060.4896975528;502637;503523.48238258576;504020.99999999633;54849.725751370985;55196.72401638047;55294;55308;55331.72334138303;33483.995480135636;33799.83100084484;33998.83000585031;57305.853882922944;57614;16148;16276.348946042262;16309.51071467858;16313.34746610146;16337.346506139858;12471.625851224479;12563.93718031404;12572.685682857818;12575;12589.929855962162;18073.548161296072;18169.36407225741;18170.545736356697;18171.454856354332;18174.819406604056;7592.772216833504;7715.922840771633;7740.445652934518;7826.099998500132;7830.960845195737;878.868169774539;897.3354427536825;928.9071092890792;1066.4774260612244;1097.5993762276871;26232.34419139537;27835.443291134063;29447.558286625717;30011.549826752616;30136.54795178074;977.5014742481386;1088.9455527223606;1091.6779550032759;1128.5372997071327;1179.8820117988305;15091.471798487;15112.395504179929;15159.166245856584;15281.654182303088;15304.38782448712;662632;669298;670021;671326;672545;55281.72359138259;55717;55761.721191393786;55855;55969.440305597236;1313.3761463304854;1347.595721283611;1353.3098119958893;1361.1492816989382;1364.2837510307168;26695.96865615255;27336.179914602595;27992.58011129794;29065.7093429063;29438.411231774815;46896.062078758914;47057.58827235188;47207;47273.81815454641;47313;553513;556544;557583;557640;557748;24763.380915477257;25298.620520691835;25316.74683253144;25729.614055789552;25768.09811656583;43758;45222.095558087996;45275;46541.30188047114;48194;37756.81121594484;38106.0473488165;38419.08562954464;38846.41730374103;39397.80301098476;37834.43248351222;38016.809915950245;38408.615913840506;39262.21475570415;39378;36584.634153658124;37226.6277337234;37945.051373715876;38125.4281185788;38241.4263786049;32338.514922276656;33482.497762533094;33917.15207119842;33963.830180848934;34015.65984340224;21654.566908662055;21851.562968740855;21928.342149735534;22055.448613784785;22098.33704988853 08:06:56 INFO - PROCESS | 1665 | |2;jquery.html;351.9859205631775;367.24897584439833;370.6108585984716;376.9057735566108;397.69774971022014;14810.481633142843;14955.47655832046;15668.764968525467;19501;20549.897250513764;14376.92811535941;18882.33911813087;19674.606507869834;19922.804631722105;19945;5126.999999999991;5432.565394768429;5435.320584926884;5436.8524432849;5438.456154384549;4583.8166473341025;5006.173981293082;5319.441458646845;5840.211571437865;5844.473997340238;5805.970970145143;5820.738066786984;5822.155787410823;5827;5850.590458667895;5550.195221692872;5818.738156782933;5862.530997520231;5875.823725288248;5882.3529411764675;4958.578520825734;5177.637565370425;5189.195674670432;5195.012947539955;5195.974020129913;12169.574064907685;13235.205887646773;13356.332183390889;13378.197308161542;13383.330833458385;2166.815820655246;2272.522770218256;2279.2934190400865;2290.977090229093;2305.181660510528;9327;10097.091261786401;10235.130013948823;12734.80897786534;14734.631634209123;1766.143420441085;1820.3901692932884;1842.5854182808894;1949.7660280766256;1956.325067851589;122334.38832805867;126501;127134;129946;131112.34443827815;11377.03295219899;11392.715182120513;11539.076873850072;11576.826347604792;11746.471408786625;14395.280235988159;14408.639784005274;14427.35076921541;14429.711405772036;14434.566962991126;6993.615351155735;7062.364387205176;8235.547044912468;8365.8326833463;8624.698135565224;6727.495437842182;7130.679119439637;8304.086550479442;8311.33509319253;8498.617562209593;4331.177076355545;4505;4522.399620218388;4527.501974782771;4656.627469802408;1728.9827101729072;1827.415227127333;1898.6582415165403;1906.3041989673948;1914.4735197820432;717.7129148340601;742.9888551671729;819.2503858968977;927.1331305229631;939.6945992552447;18117.791008251555;19368;20341.288054918303;20568.280110196072;20708.58582828335;785.5600863516449;886.8935727712586;893.2585953658448;903.263839970422;949.2311227905419;10420.478976051167;10544.736381590368;10915.39965301916;10995;11013.614523491638;478373;483427;486366;572158;578467;85143.14856851476;120042;134824;140062.29968850294;140695;900.446225571269;950.3870003847479;968.1915600473683;1011.0445628880638;1017.2523195451338;13873;15546.222688865737;17521.299148033937;18810;19196.520086997378;54357.18464223119;54619.45380546144;55488;55506.72246638902;57581.56046098881;73868;76066.61966690132;77386;78384;79783.60108199422;7093.32613401726;8031.477953932976;8056.395770317366;8064.233897779702;8329.333653307842;10279.383237005804;10830.837537437103;12249.938750306548;12838.679033023875;13425.530106446227;10766.192535559707;10872.130229581457;10958.671239862817;11191.66425007251;11309.773804524028;11223.66329010131;11290.661280161608;11507.769844603228;11514.712132196762;11558.768824623292;11049.28179668319;11354.545818167511;11574.479148438171;11661.06711463064;11676.357800321064;8126.918730812617;8180.754577362689;8280.917190828015;8364.163583641588;8380.994280686356;9316.534173291444;11153.163512736739;11261.380624065756;11309.773804524028;11347.205695601559 08:06:56 INFO - PROCESS | 1665 | |3;mootools.html;1297.2281492511954;1477.4090363854455;1610.7342288522395;1851.8333349998497;1879.0792511669279;8221.3011893989;8753.824923501534;8756.124387561249;8756.605952732127;8760.080191579887;7697.268759467842;7917.722879699211;8318.83362332753;8540.35947303953;8603.268722158624;2295.0819672131115;2322.8257880659016;2324.8605083694947;2325.4418939454495;2335.2293743064834;2276.8178545716387;2286.3483907086484;2336.2523992322463;2346.4603141277516;2346.8474549154334;2268.319504148757;2284.497410569672;2294.9885250573725;2297.6438652008965;2302.113686230805;2293.0369244917174;2312.89591968361;2317.768223177677;2318.5247024359965;2320.6635037919577;2299.356180269527;2301.183080006607;2301.1945818963227;2304.7695230476984;2306.1928325086255;8621.353398495137;8683.652653893836;8715.346349023848;8727.869081963776;8767.693130740457;5077.847664570068;5234.81678141267;5238.345206849144;5244.632875698702;5245.10833158364;3432.2963792422493;3503.6846683798326;3649;3650.5619325681087;3654.196076863086;1038.3605846798512;1072.8229842076048;1073.7369344510566;1097.9670609881637;1098.3355070182504;11269.323840569592;11411.828822567668;11416;11427.000274951934;11432.256903301342;4393.802278897458;4478.865634030984;4655.045715628288;4655.3947986761505;4661.324108004321;9732;9732.318737688436;9735.41587504752;9747.512624368754;9761.170300524393;5219.243209734643;5219.504147106095;5225.581953443715;5225.608079394061;5232.529072383428;3827.9043023924623;4249.745015299092;4318.071614602875;4401.955980440154;4799.880002999883;3367.6969072783077;3757.7745335279424;3775.5469343678383;3927.626875446828;3943.0930885896405;1234.623439850854;1251.1804767876872;1251.8685538018558;1262.7095767973417;1269.8476182858117;820.827626198493;886.3662481325883;896.2158111652304;912.6948463696978;953.2278854128178;5595.5523558116065;5783.942160578425;5936.5547583931375;5941.197938278364;5964.373740757244;391.9235749028912;420.69499612780487;428.14584903117856;429.96775241856983;431.8553284649677;3616.4756110364374;3650.288193802236;3667.688246499024;3743.47591337213;3745.232227393378;10125.898741012643;10388.740281493023;10497.10774584169;10506.842397364046;10527.94736026315;9233;10441.634542790965;10459.372437653614;10468.267221294436;10473.790524189473;7822.569758663328;8048.839023219502;8050.826276905203;8053.315468185153;8064.112947575762;4778.713277203379;5700.714964251853;5721.485066344049;5766.4233576642;5841.211436456024;8470.576471176293;9731.17285030752;9751.756206094904;9759.170470510086;9774.364666296668;9561.90438095638;9729.416235025921;9852.556634951301;9933.65232216869;9942.850857237003;6757.560758550679;6981.965090174516;7285.854282914418;7364.0426744522865;7395.741149059757;7738.2261773822165;7818.3354414875375;7823.217678232131;7839.216078392344;7959.721409750631;6231.937680623136;7245.673944672608;7338.6697598607125;7456.7762967111075;7474.701011959678;7125.786226413008;7188.317109874553;7212.783616491513;7234.421246300178;7290;6630.801075967729;6821.420179284816;6857.177138743383;6927.826804329932;6982.720691172296;4919.458859525521;4935.432425271139;4936.9259461107395;4976.278439626161;5068.6451948363265;4803.615710743063;4870.391201099863;4900.8774780630765;4936.605071594336;4960.156773348467 08:06:56 INFO - PROCESS | 1665 | |4;prototype.html;296.5033568772306;298.79681816364877;304.8021276383811;310.2167028253659;315.13024053612025;4570.520095389986;5197.402298735642;5231.816886408977;5254;5325.946740532593;4378.168148051868;4943.6539442239055;4976.402831660206;5145.614078944085;5161.251618515323;3653.342398368293;3653.4702468142104;3897.610238976108;3987.3022221111332;4027.5368332641683;3374.3757404880052;3783.6216378362083;4011.518617765872;4021.3766866135647;4049.230646177232;3432.622411534729;3996.4804575405155;3996.721868534936;3997.620226078518;4014.8193331300163;3968.6428221460205;3986.9601303987024;3988.4216788565786;4007.2185923744883;4013.411349679455;3470.791752494833;3476.5654293213347;3479.9130021749406;3494.5981212160673;3498.247876706495;4169.769917874204;4847.515248475124;5057.2828970706505;5068.138416469209;5069.8592816615965;4521.163584736802;4549.727016378994;4584.312353147021;4594.713480225542;4633;4797.664163508521;5009.974950125263;5504.422035686275;5514.972425137888;5571.632056376065;3402.9489557656407;3853.2293541291856;3856.0359910022494;3863.632954869311;3906.824192911326;5440.564754819605;5708.828735137952;5722.284714410699;5730.484256416942;5749.0906183795005;3449.1721986723005;3588.8564457421935;3873.32216862048;3886.4753258310334;3904.707146963989;3929.8603405012227;3945.408188771707;3969.047428617111;3987.960120398817;3992.7223288547966;3677.356462619031;4544.272916333371;4567.611753000966;4583.289590113538;4606.838760643362;4856.854294371175;5108.57342762185;5281.55106815925;5585.045234168008;5606.467385598362;1180.3272134883034;1186.3178672263311;1221.535816389784;1244.9066320025854;1307.8169056332122;827.6441130313902;844.9408541402042;861.8319427711536;887.1128871128872;900.3877363392955;4937.753112344369;5198.246254293106;5198.376194856642;5244.370675518962;5257.526822585985;4959;5227.294315267466;5659;5699.489635246663;5710.457506536873;4605.953940460619;4807.519248075165;4982.2811130160035;5070.7464626768515;5245.921311180336;2844.416894536615;2919.306802054803;2951.9262018449713;2952.926176845553;2955.2316397736313;4888.65779395446;5608.551315894719;5701.087825947911;5773.769049238067;5855.355910849803;4908.656394052454;5212.947870521246;5303.522682958553;5717.8570535736935;5734.311882574035;4864.92702609454;5782.6819524925695;5803.448672376117;5812.762086596606;5820.767169313265;4806.279058141306;5202.933398653343;5475.959567682127;5525.668459892419;5605.682664573904;5480.424555421623;5510.476504732044;5519.860104921309;5519.8896022080135;5533.280673512418;4827.8551643450755;5034.572061374678;5464.644798088111;5498.257735205856;5789.784145329528;3202.7597930154866;3465.54947856777;3652.251288485907;3844.4425558293333;3844.6924246060807;4455.482652301439;5183.626339020238;5627.21219029328;5640;5660.85847853807;5486.670799751868;5491.780328786804;5526.447355264441;5527.834164975057;5656.490915817596;5034.270030845433;5060.49395060491;5283.762230699705;5515.283013208257;5541.335039795089;4921.311016457627;5237.659552129099;5349.384820745664;5380.43505431924;5396.462008327765;5371.409144994126;5474.479924407175;5496.378568322434;5562;5563.388027317073;5407.783688652567;5408.026070484324;5443.863903402446;5444.02007638613;5453.536449401687 08:06:56 INFO - PROCESS | 1665 | |5;yui.html;633.1926793338492;716.7240612364238;733.2703959560239;761.2881955371724;772.7874834420535;14679;15203.695926081471;15229.847701522982;15232.61918452038;15559.688806223869;13884.028118031742;13989.020768546181;13993.720125597481;14006.439742410317;14047.086939348936;663.7975417497661;696.2723953468612;696.3419568507762;696.7839969609412;700.4851434195862;692.5290802254465;818.5702506184272;849.864021756519;856.4818284937617;857.618359829876;901.445610949268;902.1204325782343;902.4900930974012;904.0733248420389;906.0984320601011;897.9506127163004;899.2670973156856;900.2078171209326;900.7838118851494;901.625825282507;526.5497999210658;549.5466240351726;645.5319893077528;667.8263651450609;669.3072669786796;14401.135931844017;14432.567022989222;14448.855511444855;14479.92760036193;14500.854991450056;13023.348832558335;13201.73596528064;13359.666008349868;13562;13812.240326782023;11972;12118.272903625812;12227.755444891141;12405.317707526083;12423.130380873343;4338.3058710606465;4347.956520434786;4384.342348647697;4400.383946247528;4452.643788496913;70121.64939175322;87179.56410217908;91400;115378.42310788477;115892;9315.580798864068;10623.975272806441;10805.675829725122;10916.290441121302;11238.550457981753;17607;21010;21103.8944805275;21145.365639030853;21294.574108517743;7803.219678032151;7854.450188486865;7885.172056934054;7906.248906353887;7931.246531579491;4144.896377590584;4251.914961700749;4370.650347972155;4378.715383500126;4504.828744526381;3391.7117045051446;3526.559180102487;3535.7348198884674;3536.770109942897;3539.964600354015;635.7202830754453;643.1886323830656;653.738504598155;657.0768070860448;665.4077870695086;598.4344794169468;606.3663471672113;610.5878531990888;622.2564035976964;625.5433533520464;8391.24478796899;8705.561303285167;8776.429532080394;8837.248833849066;8874;579.1341943794055;587.8207146820175;598.5899658733695;600.129811772931;629.4209327418786;4231.196072746168;4231.449911511545;4254.3831144483875;4344.956550434518;4451.443569553806;121241;159932;166764;168483;173773;102869;102945.97054029364;104096;114684;148379;68619.65690171518;88404.55797721099;98499;100837.49581252047;101942.49028754958;7606.619669016416;9072.639104134432;9423.858642120236;9480.715578532656;9548.52257387114;50593;52807.20789188242;55602.721986389806;57243.30318294691;58757.4124258769;65412.67293663501;84460;86951.56524217338;89240;90890;12498.377676833297;12598.685032874251;12667;13089.934550327187;13102.475900963855;14001.929990349983;14005.229712365917;14235.35940882642;14549.41802327895;14745.557633271019;12985.610431687064;13757.31213439344;13768;13925.860741392862;13946.372413241632;9616.51917404113;12463.750724985632;13112;13366.93316533411;13538.86461135376;13066.54267100647;13235.602931912059;13291.734165316833;13354.9332253342;13849.584512464238;10661.312261156774;10788.568457261621;10955.671329860117;11441.370724610226;11505.884941150816;11085.501152447998;11115.931838242775;11228.270162439416;11322.886771132184;11372.601958931398 08:06:56 INFO - PROCESS | 1665 | __end_tp_report 08:06:56 INFO - PROCESS | 1665 | __start_cc_report 08:06:56 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,2077 08:06:56 INFO - PROCESS | 1665 | __end_cc_report 08:06:56 INFO - PROCESS | 1665 | __startTimestamp1476198416890__endTimestamp 08:06:56 INFO - PROCESS | 1665 | 08:06:56 INFO - PROCESS | 1665 | ------- Summary: start ------- 08:06:56 INFO - PROCESS | 1665 | Number of tests: 6 08:06:56 INFO - PROCESS | 1665 | 08:06:56 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5628.64 Median:5810.00 stddev:772.70 (13.3%) stddev-sans-first:750.16 08:06:56 INFO - PROCESS | 1665 | Values: 3147.8 3334.9 3340.4 3342.9 3359.0 5549.9 5577.7 5633.9 5635.5 5683.7 5621.2 5639.3 5650.5 5651.0 5651.5 5047.4 5108.4 5126.1 5131.0 5147.3 5183.7 5190.6 5218.9 5236.9 5251.1 5232.6 5241.7 5244.6 5287.7 5305.1 425.3 5210.8 5240.9 5252.1 5288.9 3260.7 5099.3 5146.6 5153.8 5231.7 5583.0 5583.1 5618.2 5639.5 5673.7 5992.0 6207.6 6212.9 6225.7 6231.9 6093.2 6115.4 6146.4 6150.4 6209.2 5698.0 5709.2 5713.1 5722.9 5772.1 6279.6 6316.9 6322.2 6322.5 6340.3 5908.7 5957.3 5963.9 5997.9 6040.8 6156.0 6191.3 6205.8 6220.3 6239.7 6158.3 6159.9 6163.3 6171.5 6175.8 5977.6 6115.1 6168.3 6169.2 6201.3 4869.2 4895.7 4899.6 4924.6 4947.6 4289.4 4301.3 4333.2 4390.2 4475.6 4825.4 5628.2 5644.7 5644.8 5690.5 6071.5 6106.5 6124.6 6131.3 6177.6 5661.0 5696.9 5716.3 5739.9 5757.7 5333.4 5349.9 5351.4 5358.9 5361.9 6145.8 6281.9 6291.4 6295.5 6314.7 5197.5 6118.7 6148.5 6163.5 6281.0 6277.6 6282.3 6294.7 6297.8 6312.3 6105.7 6134.9 6139.1 6147.1 6165.6 5117.4 6090.2 6101.5 6106.0 6116.4 5956.6 5966.7 5976.2 5989.5 5997.0 5900.4 5902.5 5924.5 5938.9 5949.0 5555.2 5716.4 5726.1 5800.5 5812.9 5983.0 6091.5 6095.4 6135.3 6138.9 5739.7 5810.0 5893.6 5896.3 5900.6 08:06:56 INFO - PROCESS | 1665 | 08:06:56 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:69411.16 Median:38791.01 stddev:155382.84 (400.6%) stddev-sans-first:155732.54 08:06:56 INFO - PROCESS | 1665 | Values: 479.6 523.1 525.4 525.5 554.7 29498.6 29684.1 31092.2 38428.0 39466.0 40636.2 41111.4 41147.4 41173.2 41224.0 9350.0 9572.9 9584.2 9587.3 9605.8 9369.0 9469.8 9483.7 9490.0 9496.2 7989.5 8039.8 9454.8 9490.1 9490.1 9433.8 9464.9 9490.0 9495.2 9509.7 9363.8 9452.4 9458.5 9462.5 9477.8 38399.0 38770.8 38782.0 38800.0 38881.8 3271.1 3296.4 3298.0 3327.2 3956.1 29308.4 29791.9 30253.8 30419.5 30957.8 3181.0 3188.9 3191.0 3197.2 3198.9 501217.0 502060.5 502637.0 503523.5 504021.0 54849.7 55196.7 55294.0 55308.0 55331.7 33484.0 33799.8 33998.8 57305.9 57614.0 16148.0 16276.3 16309.5 16313.3 16337.3 12471.6 12563.9 12572.7 12575.0 12589.9 18073.5 18169.4 18170.5 18171.5 18174.8 7592.8 7715.9 7740.4 7826.1 7831.0 878.9 897.3 928.9 1066.5 1097.6 26232.3 27835.4 29447.6 30011.5 30136.5 977.5 1088.9 1091.7 1128.5 1179.9 15091.5 15112.4 15159.2 15281.7 15304.4 662632.0 669298.0 670021.0 671326.0 672545.0 55281.7 55717.0 55761.7 55855.0 55969.4 1313.4 1347.6 1353.3 1361.1 1364.3 26696.0 27336.2 27992.6 29065.7 29438.4 46896.1 47057.6 47207.0 47273.8 47313.0 553513.0 556544.0 557583.0 557640.0 557748.0 24763.4 25298.6 25316.7 25729.6 25768.1 43758.0 45222.1 45275.0 46541.3 48194.0 37756.8 38106.0 38419.1 38846.4 39397.8 37834.4 38016.8 38408.6 39262.2 39378.0 36584.6 37226.6 37945.1 38125.4 38241.4 32338.5 33482.5 33917.2 33963.8 34015.7 21654.6 21851.6 21928.3 22055.4 22098.3 08:06:56 INFO - PROCESS | 1665 | 08:06:56 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:32422.00 Median:2275.91 stddev:88229.08 (3876.7%) stddev-sans-first:88443.72 08:06:56 INFO - PROCESS | 1665 | Values: 352.0 367.2 370.6 376.9 397.7 14810.5 14955.5 15668.8 19501.0 20549.9 14376.9 18882.3 19674.6 19922.8 19945.0 5127.0 5432.6 5435.3 5436.9 5438.5 4583.8 5006.2 5319.4 5840.2 5844.5 5806.0 5820.7 5822.2 5827.0 5850.6 5550.2 5818.7 5862.5 5875.8 5882.4 4958.6 5177.6 5189.2 5195.0 5196.0 12169.6 13235.2 13356.3 13378.2 13383.3 2166.8 2272.5 2279.3 2291.0 2305.2 9327.0 10097.1 10235.1 12734.8 14734.6 1766.1 1820.4 1842.6 1949.8 1956.3 122334.4 126501.0 127134.0 129946.0 131112.3 11377.0 11392.7 11539.1 11576.8 11746.5 14395.3 14408.6 14427.4 14429.7 14434.6 6993.6 7062.4 8235.5 8365.8 8624.7 6727.5 7130.7 8304.1 8311.3 8498.6 4331.2 4505.0 4522.4 4527.5 4656.6 1729.0 1827.4 1898.7 1906.3 1914.5 717.7 743.0 819.3 927.1 939.7 18117.8 19368.0 20341.3 20568.3 20708.6 785.6 886.9 893.3 903.3 949.2 10420.5 10544.7 10915.4 10995.0 11013.6 478373.0 483427.0 486366.0 572158.0 578467.0 85143.1 120042.0 134824.0 140062.3 140695.0 900.4 950.4 968.2 1011.0 1017.3 13873.0 15546.2 17521.3 18810.0 19196.5 54357.2 54619.5 55488.0 55506.7 57581.6 73868.0 76066.6 77386.0 78384.0 79783.6 7093.3 8031.5 8056.4 8064.2 8329.3 10279.4 10830.8 12249.9 12838.7 13425.5 10766.2 10872.1 10958.7 11191.7 11309.8 11223.7 11290.7 11507.8 11514.7 11558.8 11049.3 11354.5 11574.5 11661.1 11676.4 8126.9 8180.8 8280.9 8364.2 8381.0 9316.5 11153.2 11261.4 11309.8 11347.2 08:06:56 INFO - PROCESS | 1665 | 08:06:56 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5534.70 Median:4936.77 stddev:3118.81 (63.2%) stddev-sans-first:3111.30 08:06:56 INFO - PROCESS | 1665 | Values: 1297.2 1477.4 1610.7 1851.8 1879.1 8221.3 8753.8 8756.1 8756.6 8760.1 7697.3 7917.7 8318.8 8540.4 8603.3 2295.1 2322.8 2324.9 2325.4 2335.2 2276.8 2286.3 2336.3 2346.5 2346.8 2268.3 2284.5 2295.0 2297.6 2302.1 2293.0 2312.9 2317.8 2318.5 2320.7 2299.4 2301.2 2301.2 2304.8 2306.2 8621.4 8683.7 8715.3 8727.9 8767.7 5077.8 5234.8 5238.3 5244.6 5245.1 3432.3 3503.7 3649.0 3650.6 3654.2 1038.4 1072.8 1073.7 1098.0 1098.3 11269.3 11411.8 11416.0 11427.0 11432.3 4393.8 4478.9 4655.0 4655.4 4661.3 9732.0 9732.3 9735.4 9747.5 9761.2 5219.2 5219.5 5225.6 5225.6 5232.5 3827.9 4249.7 4318.1 4402.0 4799.9 3367.7 3757.8 3775.5 3927.6 3943.1 1234.6 1251.2 1251.9 1262.7 1269.8 820.8 886.4 896.2 912.7 953.2 5595.6 5783.9 5936.6 5941.2 5964.4 391.9 420.7 428.1 430.0 431.9 3616.5 3650.3 3667.7 3743.5 3745.2 10125.9 10388.7 10497.1 10506.8 10527.9 9233.0 10441.6 10459.4 10468.3 10473.8 7822.6 8048.8 8050.8 8053.3 8064.1 4778.7 5700.7 5721.5 5766.4 5841.2 8470.6 9731.2 9751.8 9759.2 9774.4 9561.9 9729.4 9852.6 9933.7 9942.9 6757.6 6982.0 7285.9 7364.0 7395.7 7738.2 7818.3 7823.2 7839.2 7959.7 6231.9 7245.7 7338.7 7456.8 7474.7 7125.8 7188.3 7212.8 7234.4 7290.0 6630.8 6821.4 6857.2 6927.8 6982.7 4919.5 4935.4 4936.9 4976.3 5068.6 4803.6 4870.4 4900.9 4936.6 4960.2 08:06:56 INFO - PROCESS | 1665 | 08:06:56 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4448.63 Median:5022.12 stddev:1354.43 (27.0%) stddev-sans-first:1321.89 08:06:56 INFO - PROCESS | 1665 | Values: 296.5 298.8 304.8 310.2 315.1 4570.5 5197.4 5231.8 5254.0 5325.9 4378.2 4943.7 4976.4 5145.6 5161.3 3653.3 3653.5 3897.6 3987.3 4027.5 3374.4 3783.6 4011.5 4021.4 4049.2 3432.6 3996.5 3996.7 3997.6 4014.8 3968.6 3987.0 3988.4 4007.2 4013.4 3470.8 3476.6 3479.9 3494.6 3498.2 4169.8 4847.5 5057.3 5068.1 5069.9 4521.2 4549.7 4584.3 4594.7 4633.0 4797.7 5010.0 5504.4 5515.0 5571.6 3402.9 3853.2 3856.0 3863.6 3906.8 5440.6 5708.8 5722.3 5730.5 5749.1 3449.2 3588.9 3873.3 3886.5 3904.7 3929.9 3945.4 3969.0 3988.0 3992.7 3677.4 4544.3 4567.6 4583.3 4606.8 4856.9 5108.6 5281.6 5585.0 5606.5 1180.3 1186.3 1221.5 1244.9 1307.8 827.6 844.9 861.8 887.1 900.4 4937.8 5198.2 5198.4 5244.4 5257.5 4959.0 5227.3 5659.0 5699.5 5710.5 4606.0 4807.5 4982.3 5070.7 5245.9 2844.4 2919.3 2951.9 2952.9 2955.2 4888.7 5608.6 5701.1 5773.8 5855.4 4908.7 5212.9 5303.5 5717.9 5734.3 4864.9 5782.7 5803.4 5812.8 5820.8 4806.3 5202.9 5476.0 5525.7 5605.7 5480.4 5510.5 5519.9 5519.9 5533.3 4827.9 5034.6 5464.6 5498.3 5789.8 3202.8 3465.5 3652.3 3844.4 3844.7 4455.5 5183.6 5627.2 5640.0 5660.9 5486.7 5491.8 5526.4 5527.8 5656.5 5034.3 5060.5 5283.8 5515.3 5541.3 4921.3 5237.7 5349.4 5380.4 5396.5 5371.4 5474.5 5496.4 5562.0 5563.4 5407.8 5408.0 5443.9 5444.0 5453.5 08:06:56 INFO - PROCESS | 1665 | 08:06:56 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:23234.20 Median:4253.15 stddev:37528.28 (882.4%) stddev-sans-first:37595.19 08:06:56 INFO - PROCESS | 1665 | Values: 633.2 716.7 733.3 761.3 772.8 14679.0 15203.7 15229.8 15232.6 15559.7 13884.0 13989.0 13993.7 14006.4 14047.1 663.8 696.3 696.3 696.8 700.5 692.5 818.6 849.9 856.5 857.6 901.4 902.1 902.5 904.1 906.1 898.0 899.3 900.2 900.8 901.6 526.5 549.5 645.5 667.8 669.3 14401.1 14432.6 14448.9 14479.9 14500.9 13023.3 13201.7 13359.7 13562.0 13812.2 11972.0 12118.3 12227.8 12405.3 12423.1 4338.3 4348.0 4384.3 4400.4 4452.6 70121.6 87179.6 91400.0 115378.4 115892.0 9315.6 10624.0 10805.7 10916.3 11238.6 17607.0 21010.0 21103.9 21145.4 21294.6 7803.2 7854.5 7885.2 7906.2 7931.2 4144.9 4251.9 4370.7 4378.7 4504.8 3391.7 3526.6 3535.7 3536.8 3540.0 635.7 643.2 653.7 657.1 665.4 598.4 606.4 610.6 622.3 625.5 8391.2 8705.6 8776.4 8837.2 8874.0 579.1 587.8 598.6 600.1 629.4 4231.2 4231.4 4254.4 4345.0 4451.4 121241.0 159932.0 166764.0 168483.0 173773.0 102869.0 102946.0 104096.0 114684.0 148379.0 68619.7 88404.6 98499.0 100837.5 101942.5 7606.6 9072.6 9423.9 9480.7 9548.5 50593.0 52807.2 55602.7 57243.3 58757.4 65412.7 84460.0 86951.6 89240.0 90890.0 12498.4 12598.7 12667.0 13089.9 13102.5 14001.9 14005.2 14235.4 14549.4 14745.6 12985.6 13757.3 13768.0 13925.9 13946.4 9616.5 12463.8 13112.0 13366.9 13538.9 13066.5 13235.6 13291.7 13354.9 13849.6 10661.3 10788.6 10955.7 11441.4 11505.9 11085.5 11115.9 11228.3 11322.9 11372.6 08:06:56 INFO - PROCESS | 1665 | -------- Summary: end -------- 08:06:56 INFO - PROCESS | 1665 | 08:06:57 INFO - TEST-INFO | 1665: exit 0 08:06:57 INFO - TEST-OK | dromaeo_css | took 1117551ms 08:06:57 INFO - TEST-START | kraken 08:06:57 INFO - operating with platform_type : mac_ 08:06:57 INFO - Initialising browser for kraken test... 08:06:57 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmpcV0PF_/profile http://localhost:49274/getInfo.html) 08:06:59 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 08:06:59 INFO - PROCESS | 1672 | colorDepth:24 08:06:59 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 08:06:59 INFO - PROCESS | 1672 | __metrics 08:06:59 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:06:59 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:07:00 INFO - TEST-INFO | 1672: exit 0 08:07:00 INFO - Browser initialized. 08:07:00 INFO - Running cycle 1/1 for kraken test... 08:07:00 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmpcV0PF_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:12 INFO - PROCESS | 1673 | RSS: Main: 234987520 08:07:12 INFO - PROCESS | 1673 | 08:07:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 08:07:16 INFO - PROCESS | 1673 | RSS: Main: 293736448 08:07:16 INFO - PROCESS | 1673 | 08:07:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 08:07:19 INFO - PROCESS | 1673 | RSS: Main: 293711872 08:07:19 INFO - PROCESS | 1673 | 08:07:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 08:07:23 INFO - PROCESS | 1673 | RSS: Main: 384024576 08:07:23 INFO - PROCESS | 1673 | 08:07:25 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 08:07:26 INFO - PROCESS | 1673 | RSS: Main: 286834688 08:07:26 INFO - PROCESS | 1673 | 08:07:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:07:28 INFO - PROCESS | 1673 | RSS: Main: 289484800 08:07:28 INFO - PROCESS | 1673 | 08:07:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 08:07:32 INFO - PROCESS | 1673 | RSS: Main: 328159232 08:07:32 INFO - PROCESS | 1673 | 08:07:34 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 08:07:35 INFO - PROCESS | 1673 | RSS: Main: 328105984 08:07:35 INFO - PROCESS | 1673 | 08:07:38 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 08:07:38 INFO - PROCESS | 1673 | RSS: Main: 327733248 08:07:38 INFO - PROCESS | 1673 | 08:07:40 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:07:41 INFO - PROCESS | 1673 | RSS: Main: 300793856 08:07:41 INFO - PROCESS | 1673 | 08:07:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:07:43 INFO - PROCESS | 1673 | RSS: Main: 305561600 08:07:43 INFO - PROCESS | 1673 | 08:07:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:07:46 INFO - PROCESS | 1673 | RSS: Main: 309768192 08:07:46 INFO - PROCESS | 1673 | 08:07:49 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:07:50 INFO - PROCESS | 1673 | RSS: Main: 321859584 08:07:50 INFO - PROCESS | 1673 | 08:07:53 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:07:53 INFO - PROCESS | 1673 | RSS: Main: 320589824 08:07:53 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 08:07:55 INFO - PROCESS | 1673 | RSS: Main: 364400640 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | __start_tp_report 08:07:55 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 08:07:55 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 08:07:55 INFO - PROCESS | 1673 | |i|pagename|runs| 08:07:55 INFO - PROCESS | 1673 | |0;ai-astar;112;114;115;113;115;113;114;113;114;111 08:07:55 INFO - PROCESS | 1673 | |1;audio-beat-detection;153;136;139;149;114;114;113;112;144;113 08:07:55 INFO - PROCESS | 1673 | |2;audio-dft;186;180;182;181;183;182;179;182;176;183 08:07:55 INFO - PROCESS | 1673 | |3;audio-fft;79;58;59;87;61;58;59;61;104;81 08:07:55 INFO - PROCESS | 1673 | |4;audio-oscillator;84;70;125;101;97;70;91;67;68;91 08:07:55 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;89;87;134;87;89;87;90;87;89;86 08:07:55 INFO - PROCESS | 1673 | |6;imaging-darkroom;96;97;97;97;96;96;96;98;96;98 08:07:55 INFO - PROCESS | 1673 | |7;imaging-desaturate;86;83;84;85;85;83;85;83;86;88 08:07:55 INFO - PROCESS | 1673 | |8;json-parse-financial;58;54;51;54;53;53;70;74;80;82 08:07:55 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;65;75;66;78;75;73;70;71;72;71 08:07:55 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;87;86;86;89;86;85;88;86;90;92 08:07:55 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;143;145;145;146;144;144;149;143;238;152 08:07:55 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;167;173;170;170;173;172;169;169;172;171 08:07:55 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;69;68;81;85;88;88;78;69;69;68 08:07:55 INFO - PROCESS | 1673 | __end_tp_report 08:07:55 INFO - PROCESS | 1673 | __start_cc_report 08:07:55 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1986 08:07:55 INFO - PROCESS | 1673 | __end_cc_report 08:07:55 INFO - PROCESS | 1673 | __startTimestamp1476198475846__endTimestamp 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | ------- Summary: start ------- 08:07:55 INFO - PROCESS | 1673 | Number of tests: 14 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:1.26 (1.1%) stddev-sans-first:1.24 08:07:55 INFO - PROCESS | 1673 | Values: 112.0 114.0 115.0 113.0 115.0 113.0 114.0 113.0 114.0 111.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:128.70 Median:137.50 stddev:17.00 (12.4%) stddev-sans-first:15.59 08:07:55 INFO - PROCESS | 1673 | Values: 153.0 136.0 139.0 149.0 114.0 114.0 113.0 112.0 144.0 113.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:181.40 Median:182.00 stddev:2.67 (1.5%) stddev-sans-first:2.26 08:07:55 INFO - PROCESS | 1673 | Values: 186.0 180.0 182.0 181.0 183.0 182.0 179.0 182.0 176.0 183.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:70.70 Median:61.00 stddev:16.10 (26.4%) stddev-sans-first:16.80 08:07:55 INFO - PROCESS | 1673 | Values: 79.0 58.0 59.0 87.0 61.0 58.0 59.0 61.0 104.0 81.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:77.00 stddev:18.61 (24.2%) stddev-sans-first:19.72 08:07:55 INFO - PROCESS | 1673 | Values: 84.0 70.0 125.0 101.0 97.0 70.0 91.0 67.0 68.0 91.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:88.00 stddev:14.64 (16.6%) stddev-sans-first:15.47 08:07:55 INFO - PROCESS | 1673 | Values: 89.0 87.0 134.0 87.0 89.0 87.0 90.0 87.0 89.0 86.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:96.70 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 08:07:55 INFO - PROCESS | 1673 | Values: 96.0 97.0 97.0 97.0 96.0 96.0 96.0 98.0 96.0 98.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.62 (1.9%) stddev-sans-first:1.66 08:07:55 INFO - PROCESS | 1673 | Values: 86.0 83.0 84.0 85.0 85.0 83.0 85.0 83.0 86.0 88.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:64.00 stddev:12.25 (19.1%) stddev-sans-first:12.87 08:07:55 INFO - PROCESS | 1673 | Values: 58.0 54.0 51.0 54.0 53.0 53.0 70.0 74.0 80.0 82.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.50 stddev:4.01 (5.5%) stddev-sans-first:3.46 08:07:55 INFO - PROCESS | 1673 | Values: 65.0 75.0 66.0 78.0 75.0 73.0 70.0 71.0 72.0 71.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.50 stddev:2.22 (2.5%) stddev-sans-first:2.35 08:07:55 INFO - PROCESS | 1673 | Values: 87.0 86.0 86.0 89.0 86.0 85.0 88.0 86.0 90.0 92.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:154.90 Median:145.50 stddev:29.34 (20.2%) stddev-sans-first:30.80 08:07:55 INFO - PROCESS | 1673 | Values: 143.0 145.0 145.0 146.0 144.0 144.0 149.0 143.0 238.0 152.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:171.50 stddev:1.96 (1.1%) stddev-sans-first:1.58 08:07:55 INFO - PROCESS | 1673 | Values: 167.0 173.0 170.0 170.0 173.0 172.0 169.0 169.0 172.0 171.0 08:07:55 INFO - PROCESS | 1673 | 08:07:55 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:79.50 stddev:8.64 (10.9%) stddev-sans-first:8.75 08:07:55 INFO - PROCESS | 1673 | Values: 69.0 68.0 81.0 85.0 88.0 88.0 78.0 69.0 69.0 68.0 08:07:55 INFO - PROCESS | 1673 | -------- Summary: end -------- 08:07:55 INFO - PROCESS | 1673 | 08:07:56 INFO - TEST-INFO | 1673: exit 0 08:07:56 INFO - TEST-OK | kraken | took 59182ms 08:07:56 INFO - SUITE-END | took 1176s 08:07:57 INFO - Completed test suite (00:19:37) 08:07:57 INFO - javascript benchmark 08:07:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.826869522176, 3334.9333013339733, 3340.3653305871876, 3342.933141337172, 3358.966410335896, 5549.861253468665, 5577.749001294941, 5633.887322253552, 5635.549156067515, 5683.658980461175, 5621.184928185411, 5639.295088113986, 5650.5479561635075, 5650.982823091852, 5651.519620832224, 5047.419546752125, 5108.438071812097, 5126.102931986906, 5130.974345128269, 5147.330846989886, 5183.663061900983, 5190.584753219733, 5218.947810521903, 5236.947630523703, 5251.081060814361, 5232.6075544334135, 5241.737913104349, 5244.554212891909, 5287.682739035651, 5305.071612467822, 425.32793140930073, 5210.7655155517905, 5240.868978275574, 5252.080885844962, 5288.894222115536, 3260.703280372404, 5099.286099946011, 5146.614003949681, 5153.768080436389, 5231.659942103751, 5583.0, 5583.134614134816, 5618.185363122365, 5639.548836093103, 5673.716314184274, 5992.0, 6207.6275423474735, 6212.9068063979075, 6225.688715564249, 6231.906521402183, 6093.248624977057, 6115.449609535119, 6146.385361463817, 6150.354212807635, 6209.233502512713, 5698.0, 5709.172170035322, 5713.114467257582, 5722.885542289131, 5772.076467765221, 6279.623222606567, 6316.9368306317265, 6322.209723784527, 6322.4942004639515, 6340.334264902119, 5908.734106965197, 5957.255343082114, 5963.850903727354, 5997.940020599825, 6040.818775436744, 6156.0, 6191.318954915046, 6205.751769929152, 6220.25356957159, 6239.719212635442, 6158.291796443466, 6159.938400616026, 6163.260408750979, 6171.47542458896, 6175.783847565313, 5977.551683623746, 6115.143879856823, 6168.321484636686, 6169.2288463942, 6201.286852011986, 4869.196582563837, 4895.73073480962, 4899.559039686445, 4924.556789888928, 4947.60419166473, 4289.378040184156, 4301.333293339538, 4333.1766964276685, 4390.1878152541885, 4475.552444755498, 4825.396825396825, 5628.212050312959, 5644.717764111778, 5644.774209031675, 5690.487856092972, 6071.544634152457, 6106.460667180062, 6124.632522048602, 6131.315499378962, 6177.62934223948, 5661.009323368394, 5696.8860622787315, 5716.28546431696, 5739.85650358736, 5757.6833274169485, 5333.413324534298, 5349.919751203735, 5351.357837059578, 5358.91961620576, 5361.919571206435, 6145.784897528565, 6281.905771413341, 6291.402316779899, 6295.496360291074, 6314.715837787218, 5197.532222100029, 6118.694065296806, 6148.538859585638, 6163.476104530986, 6281.0, 6277.5605707600025, 6282.340354262919, 6294.716737746904, 6297.811065668037, 6312.2740884796995, 6105.664188469676, 6134.938650613615, 6139.140520327069, 6147.108669243024, 6165.568410211242, 5117.43708192106, 6090.23872015998, 6101.450869421773, 6106.023036314346, 6116.366205733216, 5956.583039187215, 5966.701664916824, 5976.193213916065, 5989.490893274121, 5997.0404735242155, 5900.350961394329, 5902.498287645598, 5924.52603791687, 5938.940610593839, 5949.0481522956115, 5555.194496797861, 5716.371199168005, 5726.112452569859, 5800.50695690871, 5812.94187058141, 5983.0, 6091.543134264859, 6095.408112664776, 6135.325114237341, 6138.938610613836, 5739.655620662774, 5810.0, 5893.6463812171405, 5896.321922978912, 5900.64596124234], "value": 5581.605211931052, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.5803671787185, 523.1446584833795, 525.3879230696239, 525.5007742644488, 554.7087778916072, 29498.557521637165, 29684.10947671568, 31092.22269443265, 38428.03929901754, 39466.0, 40636.18727625453, 41111.383329250086, 41147.38278925818, 41173.17653646933, 41224.0, 9350.018248083956, 9572.904270957306, 9584.233261339112, 9587.328886977913, 9605.759856003586, 9369.0, 9469.763255918588, 9483.715488535356, 9490.0, 9496.240300775922, 7989.480683755566, 8039.758807235792, 9454.81090378192, 9490.050994900525, 9490.145886870181, 9433.76415589609, 9464.905350946507, 9489.952550237274, 9495.240380769523, 9509.667161649379, 9363.812723745486, 9452.385594936308, 9458.52707364629, 9462.52687365636, 9477.810443791155, 38399.0, 38770.83687489352, 38782.0, 38800.029999249964, 38881.805590972144, 3271.1331497153274, 3296.3736889990823, 3298.0, 3327.234736010707, 3956.1494278729924, 29308.41383172346, 29791.851040744874, 30253.848730756425, 30419.543706844415, 30957.8452107738, 3180.9522857157162, 3188.856501457417, 3190.952135717966, 3197.2486465680545, 3198.9200269993203, 501217.0, 502060.4896975528, 502637.0, 503523.48238258576, 504020.99999999633, 54849.725751370985, 55196.72401638047, 55294.0, 55308.0, 55331.72334138303, 33483.995480135636, 33799.83100084484, 33998.83000585031, 57305.853882922944, 57614.0, 16148.0, 16276.348946042262, 16309.51071467858, 16313.34746610146, 16337.346506139858, 12471.625851224479, 12563.93718031404, 12572.685682857818, 12575.0, 12589.929855962162, 18073.548161296072, 18169.36407225741, 18170.545736356697, 18171.454856354332, 18174.819406604056, 7592.772216833504, 7715.922840771633, 7740.445652934518, 7826.099998500132, 7830.960845195737, 878.868169774539, 897.3354427536825, 928.9071092890792, 1066.4774260612244, 1097.5993762276871, 26232.34419139537, 27835.443291134063, 29447.558286625717, 30011.549826752616, 30136.54795178074, 977.5014742481386, 1088.9455527223606, 1091.6779550032759, 1128.5372997071327, 1179.8820117988305, 15091.471798487, 15112.395504179929, 15159.166245856584, 15281.654182303088, 15304.38782448712, 662632.0, 669298.0, 670021.0, 671326.0, 672545.0, 55281.72359138259, 55717.0, 55761.721191393786, 55855.0, 55969.440305597236, 1313.3761463304854, 1347.595721283611, 1353.3098119958893, 1361.1492816989382, 1364.2837510307168, 26695.96865615255, 27336.179914602595, 27992.58011129794, 29065.7093429063, 29438.411231774815, 46896.062078758914, 47057.58827235188, 47207.0, 47273.81815454641, 47313.0, 553513.0, 556544.0, 557583.0, 557640.0, 557748.0, 24763.380915477257, 25298.620520691835, 25316.74683253144, 25729.614055789552, 25768.09811656583, 43758.0, 45222.095558087996, 45275.0, 46541.30188047114, 48194.0, 37756.81121594484, 38106.0473488165, 38419.08562954464, 38846.41730374103, 39397.80301098476, 37834.43248351222, 38016.809915950245, 38408.615913840506, 39262.21475570415, 39378.0, 36584.634153658124, 37226.6277337234, 37945.051373715876, 38125.4281185788, 38241.4263786049, 32338.514922276656, 33482.497762533094, 33917.15207119842, 33963.830180848934, 34015.65984340224, 21654.566908662055, 21851.562968740855, 21928.342149735534, 22055.448613784785, 22098.33704988853], "value": 19293.675593172713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.9859205631775, 367.24897584439833, 370.6108585984716, 376.9057735566108, 397.69774971022014, 14810.481633142843, 14955.47655832046, 15668.764968525467, 19501.0, 20549.897250513764, 14376.92811535941, 18882.33911813087, 19674.606507869834, 19922.804631722105, 19945.0, 5126.999999999991, 5432.565394768429, 5435.320584926884, 5436.8524432849, 5438.456154384549, 4583.8166473341025, 5006.173981293082, 5319.441458646845, 5840.211571437865, 5844.473997340238, 5805.970970145143, 5820.738066786984, 5822.155787410823, 5827.0, 5850.590458667895, 5550.195221692872, 5818.738156782933, 5862.530997520231, 5875.823725288248, 5882.3529411764675, 4958.578520825734, 5177.637565370425, 5189.195674670432, 5195.012947539955, 5195.974020129913, 12169.574064907685, 13235.205887646773, 13356.332183390889, 13378.197308161542, 13383.330833458385, 2166.815820655246, 2272.522770218256, 2279.2934190400865, 2290.977090229093, 2305.181660510528, 9327.0, 10097.091261786401, 10235.130013948823, 12734.80897786534, 14734.631634209123, 1766.143420441085, 1820.3901692932884, 1842.5854182808894, 1949.7660280766256, 1956.325067851589, 122334.38832805867, 126501.0, 127134.0, 129946.0, 131112.34443827815, 11377.03295219899, 11392.715182120513, 11539.076873850072, 11576.826347604792, 11746.471408786625, 14395.280235988159, 14408.639784005274, 14427.35076921541, 14429.711405772036, 14434.566962991126, 6993.615351155735, 7062.364387205176, 8235.547044912468, 8365.8326833463, 8624.698135565224, 6727.495437842182, 7130.679119439637, 8304.086550479442, 8311.33509319253, 8498.617562209593, 4331.177076355545, 4505.0, 4522.399620218388, 4527.501974782771, 4656.627469802408, 1728.9827101729072, 1827.415227127333, 1898.6582415165403, 1906.3041989673948, 1914.4735197820432, 717.7129148340601, 742.9888551671729, 819.2503858968977, 927.1331305229631, 939.6945992552447, 18117.791008251555, 19368.0, 20341.288054918303, 20568.280110196072, 20708.58582828335, 785.5600863516449, 886.8935727712586, 893.2585953658448, 903.263839970422, 949.2311227905419, 10420.478976051167, 10544.736381590368, 10915.39965301916, 10995.0, 11013.614523491638, 478373.0, 483427.0, 486366.0, 572158.0, 578467.0, 85143.14856851476, 120042.0, 134824.0, 140062.29968850294, 140695.0, 900.446225571269, 950.3870003847479, 968.1915600473683, 1011.0445628880638, 1017.2523195451338, 13873.0, 15546.222688865737, 17521.299148033937, 18810.0, 19196.520086997378, 54357.18464223119, 54619.45380546144, 55488.0, 55506.72246638902, 57581.56046098881, 73868.0, 76066.61966690132, 77386.0, 78384.0, 79783.60108199422, 7093.32613401726, 8031.477953932976, 8056.395770317366, 8064.233897779702, 8329.333653307842, 10279.383237005804, 10830.837537437103, 12249.938750306548, 12838.679033023875, 13425.530106446227, 10766.192535559707, 10872.130229581457, 10958.671239862817, 11191.66425007251, 11309.773804524028, 11223.66329010131, 11290.661280161608, 11507.769844603228, 11514.712132196762, 11558.768824623292, 11049.28179668319, 11354.545818167511, 11574.479148438171, 11661.06711463064, 11676.357800321064, 8126.918730812617, 8180.754577362689, 8280.917190828015, 8364.163583641588, 8380.994280686356, 9316.534173291444, 11153.163512736739, 11261.380624065756, 11309.773804524028, 11347.205695601559], "value": 9113.474024069259, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.2281492511954, 1477.4090363854455, 1610.7342288522395, 1851.8333349998497, 1879.0792511669279, 8221.3011893989, 8753.824923501534, 8756.124387561249, 8756.605952732127, 8760.080191579887, 7697.268759467842, 7917.722879699211, 8318.83362332753, 8540.35947303953, 8603.268722158624, 2295.0819672131115, 2322.8257880659016, 2324.8605083694947, 2325.4418939454495, 2335.2293743064834, 2276.8178545716387, 2286.3483907086484, 2336.2523992322463, 2346.4603141277516, 2346.8474549154334, 2268.319504148757, 2284.497410569672, 2294.9885250573725, 2297.6438652008965, 2302.113686230805, 2293.0369244917174, 2312.89591968361, 2317.768223177677, 2318.5247024359965, 2320.6635037919577, 2299.356180269527, 2301.183080006607, 2301.1945818963227, 2304.7695230476984, 2306.1928325086255, 8621.353398495137, 8683.652653893836, 8715.346349023848, 8727.869081963776, 8767.693130740457, 5077.847664570068, 5234.81678141267, 5238.345206849144, 5244.632875698702, 5245.10833158364, 3432.2963792422493, 3503.6846683798326, 3649.0, 3650.5619325681087, 3654.196076863086, 1038.3605846798512, 1072.8229842076048, 1073.7369344510566, 1097.9670609881637, 1098.3355070182504, 11269.323840569592, 11411.828822567668, 11416.0, 11427.000274951934, 11432.256903301342, 4393.802278897458, 4478.865634030984, 4655.045715628288, 4655.3947986761505, 4661.324108004321, 9732.0, 9732.318737688436, 9735.41587504752, 9747.512624368754, 9761.170300524393, 5219.243209734643, 5219.504147106095, 5225.581953443715, 5225.608079394061, 5232.529072383428, 3827.9043023924623, 4249.745015299092, 4318.071614602875, 4401.955980440154, 4799.880002999883, 3367.6969072783077, 3757.7745335279424, 3775.5469343678383, 3927.626875446828, 3943.0930885896405, 1234.623439850854, 1251.1804767876872, 1251.8685538018558, 1262.7095767973417, 1269.8476182858117, 820.827626198493, 886.3662481325883, 896.2158111652304, 912.6948463696978, 953.2278854128178, 5595.5523558116065, 5783.942160578425, 5936.5547583931375, 5941.197938278364, 5964.373740757244, 391.9235749028912, 420.69499612780487, 428.14584903117856, 429.96775241856983, 431.8553284649677, 3616.4756110364374, 3650.288193802236, 3667.688246499024, 3743.47591337213, 3745.232227393378, 10125.898741012643, 10388.740281493023, 10497.10774584169, 10506.842397364046, 10527.94736026315, 9233.0, 10441.634542790965, 10459.372437653614, 10468.267221294436, 10473.790524189473, 7822.569758663328, 8048.839023219502, 8050.826276905203, 8053.315468185153, 8064.112947575762, 4778.713277203379, 5700.714964251853, 5721.485066344049, 5766.4233576642, 5841.211436456024, 8470.576471176293, 9731.17285030752, 9751.756206094904, 9759.170470510086, 9774.364666296668, 9561.90438095638, 9729.416235025921, 9852.556634951301, 9933.65232216869, 9942.850857237003, 6757.560758550679, 6981.965090174516, 7285.854282914418, 7364.0426744522865, 7395.741149059757, 7738.2261773822165, 7818.3354414875375, 7823.217678232131, 7839.216078392344, 7959.721409750631, 6231.937680623136, 7245.673944672608, 7338.6697598607125, 7456.7762967111075, 7474.701011959678, 7125.786226413008, 7188.317109874553, 7212.783616491513, 7234.421246300178, 7290.0, 6630.801075967729, 6821.420179284816, 6857.177138743383, 6927.826804329932, 6982.720691172296, 4919.458859525521, 4935.432425271139, 4936.9259461107395, 4976.278439626161, 5068.6451948363265, 4803.615710743063, 4870.391201099863, 4900.8774780630765, 4936.605071594336, 4960.156773348467], "value": 4378.755404808727, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.5033568772306, 298.79681816364877, 304.8021276383811, 310.2167028253659, 315.13024053612025, 4570.520095389986, 5197.402298735642, 5231.816886408977, 5254.0, 5325.946740532593, 4378.168148051868, 4943.6539442239055, 4976.402831660206, 5145.614078944085, 5161.251618515323, 3653.342398368293, 3653.4702468142104, 3897.610238976108, 3987.3022221111332, 4027.5368332641683, 3374.3757404880052, 3783.6216378362083, 4011.518617765872, 4021.3766866135647, 4049.230646177232, 3432.622411534729, 3996.4804575405155, 3996.721868534936, 3997.620226078518, 4014.8193331300163, 3968.6428221460205, 3986.9601303987024, 3988.4216788565786, 4007.2185923744883, 4013.411349679455, 3470.791752494833, 3476.5654293213347, 3479.9130021749406, 3494.5981212160673, 3498.247876706495, 4169.769917874204, 4847.515248475124, 5057.2828970706505, 5068.138416469209, 5069.8592816615965, 4521.163584736802, 4549.727016378994, 4584.312353147021, 4594.713480225542, 4633.0, 4797.664163508521, 5009.974950125263, 5504.422035686275, 5514.972425137888, 5571.632056376065, 3402.9489557656407, 3853.2293541291856, 3856.0359910022494, 3863.632954869311, 3906.824192911326, 5440.564754819605, 5708.828735137952, 5722.284714410699, 5730.484256416942, 5749.0906183795005, 3449.1721986723005, 3588.8564457421935, 3873.32216862048, 3886.4753258310334, 3904.707146963989, 3929.8603405012227, 3945.408188771707, 3969.047428617111, 3987.960120398817, 3992.7223288547966, 3677.356462619031, 4544.272916333371, 4567.611753000966, 4583.289590113538, 4606.838760643362, 4856.854294371175, 5108.57342762185, 5281.55106815925, 5585.045234168008, 5606.467385598362, 1180.3272134883034, 1186.3178672263311, 1221.535816389784, 1244.9066320025854, 1307.8169056332122, 827.6441130313902, 844.9408541402042, 861.8319427711536, 887.1128871128872, 900.3877363392955, 4937.753112344369, 5198.246254293106, 5198.376194856642, 5244.370675518962, 5257.526822585985, 4959.0, 5227.294315267466, 5659.0, 5699.489635246663, 5710.457506536873, 4605.953940460619, 4807.519248075165, 4982.2811130160035, 5070.7464626768515, 5245.921311180336, 2844.416894536615, 2919.306802054803, 2951.9262018449713, 2952.926176845553, 2955.2316397736313, 4888.65779395446, 5608.551315894719, 5701.087825947911, 5773.769049238067, 5855.355910849803, 4908.656394052454, 5212.947870521246, 5303.522682958553, 5717.8570535736935, 5734.311882574035, 4864.92702609454, 5782.6819524925695, 5803.448672376117, 5812.762086596606, 5820.767169313265, 4806.279058141306, 5202.933398653343, 5475.959567682127, 5525.668459892419, 5605.682664573904, 5480.424555421623, 5510.476504732044, 5519.860104921309, 5519.8896022080135, 5533.280673512418, 4827.8551643450755, 5034.572061374678, 5464.644798088111, 5498.257735205856, 5789.784145329528, 3202.7597930154866, 3465.54947856777, 3652.251288485907, 3844.4425558293333, 3844.6924246060807, 4455.482652301439, 5183.626339020238, 5627.21219029328, 5640.0, 5660.85847853807, 5486.670799751868, 5491.780328786804, 5526.447355264441, 5527.834164975057, 5656.490915817596, 5034.270030845433, 5060.49395060491, 5283.762230699705, 5515.283013208257, 5541.335039795089, 4921.311016457627, 5237.659552129099, 5349.384820745664, 5380.43505431924, 5396.462008327765, 5371.409144994126, 5474.479924407175, 5496.378568322434, 5562.0, 5563.388027317073, 5407.783688652567, 5408.026070484324, 5443.863903402446, 5444.02007638613, 5453.536449401687], "value": 4013.078663433157, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.1926793338492, 716.7240612364238, 733.2703959560239, 761.2881955371724, 772.7874834420535, 14679.0, 15203.695926081471, 15229.847701522982, 15232.61918452038, 15559.688806223869, 13884.028118031742, 13989.020768546181, 13993.720125597481, 14006.439742410317, 14047.086939348936, 663.7975417497661, 696.2723953468612, 696.3419568507762, 696.7839969609412, 700.4851434195862, 692.5290802254465, 818.5702506184272, 849.864021756519, 856.4818284937617, 857.618359829876, 901.445610949268, 902.1204325782343, 902.4900930974012, 904.0733248420389, 906.0984320601011, 897.9506127163004, 899.2670973156856, 900.2078171209326, 900.7838118851494, 901.625825282507, 526.5497999210658, 549.5466240351726, 645.5319893077528, 667.8263651450609, 669.3072669786796, 14401.135931844017, 14432.567022989222, 14448.855511444855, 14479.92760036193, 14500.854991450056, 13023.348832558335, 13201.73596528064, 13359.666008349868, 13562.0, 13812.240326782023, 11972.0, 12118.272903625812, 12227.755444891141, 12405.317707526083, 12423.130380873343, 4338.3058710606465, 4347.956520434786, 4384.342348647697, 4400.383946247528, 4452.643788496913, 70121.64939175322, 87179.56410217908, 91400.0, 115378.42310788477, 115892.0, 9315.580798864068, 10623.975272806441, 10805.675829725122, 10916.290441121302, 11238.550457981753, 17607.0, 21010.0, 21103.8944805275, 21145.365639030853, 21294.574108517743, 7803.219678032151, 7854.450188486865, 7885.172056934054, 7906.248906353887, 7931.246531579491, 4144.896377590584, 4251.914961700749, 4370.650347972155, 4378.715383500126, 4504.828744526381, 3391.7117045051446, 3526.559180102487, 3535.7348198884674, 3536.770109942897, 3539.964600354015, 635.7202830754453, 643.1886323830656, 653.738504598155, 657.0768070860448, 665.4077870695086, 598.4344794169468, 606.3663471672113, 610.5878531990888, 622.2564035976964, 625.5433533520464, 8391.24478796899, 8705.561303285167, 8776.429532080394, 8837.248833849066, 8874.0, 579.1341943794055, 587.8207146820175, 598.5899658733695, 600.129811772931, 629.4209327418786, 4231.196072746168, 4231.449911511545, 4254.3831144483875, 4344.956550434518, 4451.443569553806, 121241.0, 159932.0, 166764.0, 168483.0, 173773.0, 102869.0, 102945.97054029364, 104096.0, 114684.0, 148379.0, 68619.65690171518, 88404.55797721099, 98499.0, 100837.49581252047, 101942.49028754958, 7606.619669016416, 9072.639104134432, 9423.858642120236, 9480.715578532656, 9548.52257387114, 50593.0, 52807.20789188242, 55602.721986389806, 57243.30318294691, 58757.4124258769, 65412.67293663501, 84460.0, 86951.56524217338, 89240.0, 90890.0, 12498.377676833297, 12598.685032874251, 12667.0, 13089.934550327187, 13102.475900963855, 14001.929990349983, 14005.229712365917, 14235.35940882642, 14549.41802327895, 14745.557633271019, 12985.610431687064, 13757.31213439344, 13768.0, 13925.860741392862, 13946.372413241632, 9616.51917404113, 12463.750724985632, 13112.0, 13366.93316533411, 13538.86461135376, 13066.54267100647, 13235.602931912059, 13291.734165316833, 13354.9332253342, 13849.584512464238, 10661.312261156774, 10788.568457261621, 10955.671329860117, 11441.370724610226, 11505.884941150816, 11085.501152447998, 11115.931838242775, 11228.270162439416, 11322.886771132184, 11372.601958931398], "value": 7523.421145886408, "unit": "score"}], "name": "dromaeo_css", "value": 7115.270919012246, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 115.0, 113.0, 115.0, 113.0, 114.0, 113.0, 114.0, 111.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 136.0, 139.0, 149.0, 114.0, 114.0, 113.0, 112.0, 144.0, 113.0], "value": 128.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 180.0, 182.0, 181.0, 183.0, 182.0, 179.0, 182.0, 176.0, 183.0], "value": 181.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 87.0, 61.0, 58.0, 59.0, 61.0, 104.0, 81.0], "value": 70.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 125.0, 101.0, 97.0, 70.0, 91.0, 67.0, 68.0, 91.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 134.0, 87.0, 89.0, 87.0, 90.0, 87.0, 89.0, 86.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 98.0, 96.0, 98.0], "value": 96.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 84.0, 85.0, 85.0, 83.0, 85.0, 83.0, 86.0, 88.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 51.0, 54.0, 53.0, 53.0, 70.0, 74.0, 80.0, 82.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 66.0, 78.0, 75.0, 73.0, 70.0, 71.0, 72.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 89.0, 86.0, 85.0, 88.0, 86.0, 90.0, 92.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 145.0, 145.0, 146.0, 144.0, 144.0, 149.0, 143.0, 238.0, 152.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 173.0, 170.0, 170.0, 173.0, 172.0, 169.0, 169.0, 172.0, 171.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 81.0, 85.0, 88.0, 88.0, 78.0, 69.0, 69.0, 68.0], "value": 76.3, "unit": "score"}], "name": "kraken", "value": 1478.3999999999999, "alertThreshold": 2.0}]} 08:07:57 INFO - Return code: 0 08:07:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:07:57 INFO - # TBPL SUCCESS # 08:07:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:07:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:07:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:07:57 INFO - 2016-10-11 08:07:57.207 screenresolution[1677:11230] starting screenresolution argv=screenresolution get 08:07:57 INFO - 2016-10-11 08:07:57.210 screenresolution[1677:11230] Display 0: 1600x1200x32@60 08:07:57 INFO - 2016-10-11 08:07:57.216 screenresolution[1678:11233] starting screenresolution argv=screenresolution list 08:07:57 INFO - Available Modes on Display 0 08:07:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:07:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:07:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:07:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:07:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:07:57 INFO - Intel Iris: 08:07:57 INFO - Chipset Model: Intel Iris 08:07:57 INFO - Type: GPU 08:07:57 INFO - Bus: Built-In 08:07:57 INFO - VRAM (Dynamic, Max): 1536 MB 08:07:57 INFO - Vendor: Intel (0x8086) 08:07:57 INFO - Device ID: 0x0a2e 08:07:57 INFO - Revision ID: 0x0009 08:07:57 INFO - Displays: 08:07:57 INFO - Display: 08:07:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:07:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:07:57 INFO - Display Serial Number: 1600x1200 60 08:07:57 INFO - Main Display: Yes 08:07:57 INFO - Mirror: Off 08:07:57 INFO - Online: Yes 08:07:57 INFO - Rotation: Supported 08:07:57 INFO - Return code: 0 08:07:57 INFO - Running post-action listener: _resource_record_post_action 08:07:57 INFO - [mozharness: 2016-10-11 15:07:57.451132Z] Finished run-tests step (success) 08:07:57 INFO - Running post-run listener: _resource_record_post_run 08:07:57 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 32156672; Write bytes: 709180416; Read time: 201; Write time: 2009 08:07:57 INFO - TinderboxPrint: CPU usage
53.7% 08:07:57 INFO - TinderboxPrint: I/O read bytes / time
32,156,672 / 201 08:07:57 INFO - TinderboxPrint: I/O write bytes / time
709,180,416 / 2,009 08:07:57 INFO - TinderboxPrint: CPU idle
2,245.0 (46.3%) 08:07:57 INFO - TinderboxPrint: CPU system
970.8 (20.0%) 08:07:57 INFO - TinderboxPrint: CPU user
1,634.0 (33.7%) 08:07:57 INFO - TinderboxPrint: Swap in / out
436,109,312 / 0 08:07:57 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 408089088; Write bytes: 409614336; Read time: 30795; Write time: 876 08:07:57 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 29195264; Write bytes: 297960448; Read time: 179; Write time: 1125 08:07:57 INFO - Running post-run listener: _upload_blobber_files 08:07:57 INFO - Blob upload gear active. 08:07:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:57 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 08:07:57 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:07:57 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:07:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:07:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:07:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:58 INFO - (blobuploader) - INFO - Done attempting. 08:07:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:07:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:08:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:00 INFO - (blobuploader) - INFO - Done attempting. 08:08:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:08:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:08:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:02 INFO - (blobuploader) - INFO - Done attempting. 08:08:02 INFO - (blobuploader) - INFO - Iteration through files over. 08:08:02 INFO - Return code: 0 08:08:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:08:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:08:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2f9a60c4921b00bf59b8f455430a87f5211430a6797193d4d7a733903b7b0726edb49d2882ebf0de9e045ba0a48bc0f4c55ac85a36d962f65dd920a84daef393", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/afbde3cd0ec8df7e784078c81a9aaec4a6e609329f8227774ab517d539e8404cd2e3cfc3c78d52aa4a4a54d7b6e6964ab54fd1a023d54b6322183bad3b8dd98b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f61ad956be938b1b31d6505cd070602642b07417f0e632c7a5df156cbe7ea1f877a7fcd71a711c00c6fee1735294bb37f11e31c8adbfc4da1a0391eae3dcd065"} 08:08:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:08:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:08:02 INFO - Contents: 08:08:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2f9a60c4921b00bf59b8f455430a87f5211430a6797193d4d7a733903b7b0726edb49d2882ebf0de9e045ba0a48bc0f4c55ac85a36d962f65dd920a84daef393", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/afbde3cd0ec8df7e784078c81a9aaec4a6e609329f8227774ab517d539e8404cd2e3cfc3c78d52aa4a4a54d7b6e6964ab54fd1a023d54b6322183bad3b8dd98b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f61ad956be938b1b31d6505cd070602642b07417f0e632c7a5df156cbe7ea1f877a7fcd71a711c00c6fee1735294bb37f11e31c8adbfc4da1a0391eae3dcd065"} 08:08:02 INFO - Running post-run listener: copy_logs_to_upload_dir 08:08:02 INFO - Copying logs to upload dir... 08:08:02 INFO - mkdir: /builds/slave/test/build/upload/logs 08:08:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.707100 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-11 08:08:02.684933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 08:08:02.688371) ========= 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.9jiAGRjQNx/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.abZGV9wWF3/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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/Autoland/sha512/2f9a60c4921b00bf59b8f455430a87f5211430a6797193d4d7a733903b7b0726edb49d2882ebf0de9e045ba0a48bc0f4c55ac85a36d962f65dd920a84daef393", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/afbde3cd0ec8df7e784078c81a9aaec4a6e609329f8227774ab517d539e8404cd2e3cfc3c78d52aa4a4a54d7b6e6964ab54fd1a023d54b6322183bad3b8dd98b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f61ad956be938b1b31d6505cd070602642b07417f0e632c7a5df156cbe7ea1f877a7fcd71a711c00c6fee1735294bb37f11e31c8adbfc4da1a0391eae3dcd065"} build_url:https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011026 build_url: 'https://queue.taskcluster.net/v1/task/J72mDMjeQF2l9WFwJkQnJA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2f9a60c4921b00bf59b8f455430a87f5211430a6797193d4d7a733903b7b0726edb49d2882ebf0de9e045ba0a48bc0f4c55ac85a36d962f65dd920a84daef393", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/afbde3cd0ec8df7e784078c81a9aaec4a6e609329f8227774ab517d539e8404cd2e3cfc3c78d52aa4a4a54d7b6e6964ab54fd1a023d54b6322183bad3b8dd98b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f61ad956be938b1b31d6505cd070602642b07417f0e632c7a5df156cbe7ea1f877a7fcd71a711c00c6fee1735294bb37f11e31c8adbfc4da1a0391eae3dcd065"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 08:08:02.721986) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 08:08:02.722319) ========= 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.9jiAGRjQNx/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.abZGV9wWF3/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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.005266 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 08:08:02.770774) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 08:08:02.771097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 08:08:02.771438) ========= ========= Total master_lag: 0.18 =========