builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0325 starttime: 1475617384.63 results: success (0) buildid: 20161004113402 builduid: 61e0ff1d711e4a6bb1c5ec9346b695e9 revision: ad324639bfaeba6d7be3b732295b6a27d0c54e0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 14:43:04.633647) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 14:43:04.634074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 14:43:04.634346) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 14:43:04.658305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:43:04.658607) ========= 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.bL77nRpOvF/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.i5goNQsdu4/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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-04 14:43:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2016-10-04 14:43:04 (19.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091321 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:43:04.771726) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:43:04.772052) ========= 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.bL77nRpOvF/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.i5goNQsdu4/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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.026661 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:43:04.820582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 14:43:04.820944) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ad324639bfaeba6d7be3b732295b6a27d0c54e0a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ad324639bfaeba6d7be3b732295b6a27d0c54e0a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bL77nRpOvF/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.i5goNQsdu4/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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-04 14:43:04,898 truncating revision to first 12 chars 2016-10-04 14:43:04,898 Setting DEBUG logging. 2016-10-04 14:43:04,898 attempt 1/10 2016-10-04 14:43:04,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ad324639bfae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 14:43:06,376 unpacking tar archive at: fx-team-ad324639bfae/testing/mozharness/ program finished with exit code 0 elapsedTime=1.746102 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 14:43:06.588592) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 14:43:06.588946) ========= script_repo_revision: ad324639bfaeba6d7be3b732295b6a27d0c54e0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 14:43:06.589345) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 14:43:06.589609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 14:43:06.607305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-04 14:43:06.607577) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bL77nRpOvF/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.i5goNQsdu4/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 14:43:06 INFO - MultiFileLogger online at 20161004 14:43:06 in /builds/slave/test 14:43:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:43:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:43:06 INFO - {'append_to_log': False, 14:43:06 INFO - 'base_work_dir': '/builds/slave/test', 14:43:06 INFO - 'blob_upload_branch': 'Fx-Team', 14:43:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:43:06 INFO - 'branch': 'Fx-Team', 14:43:06 INFO - 'buildbot_json_path': 'buildprops.json', 14:43:06 INFO - 'config_files': ('talos/mac_config.py',), 14:43:06 INFO - 'default_actions': ('clobber', 14:43:06 INFO - 'read-buildbot-config', 14:43:06 INFO - 'download-and-extract', 14:43:06 INFO - 'populate-webroot', 14:43:06 INFO - 'create-virtualenv', 14:43:06 INFO - 'install', 14:43:06 INFO - 'run-tests'), 14:43:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:43:06 INFO - 'download_minidump_stackwalk': True, 14:43:06 INFO - 'download_symbols': 'ondemand', 14:43:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:43:06 INFO - 'tooltool.py': '/tools/tooltool.py', 14:43:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:43:06 INFO - '/tools/misc-python/virtualenv.py')}, 14:43:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:43:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:43:06 INFO - 'installer_path': 'installer.exe', 14:43:06 INFO - 'log_level': 'info', 14:43:06 INFO - 'log_name': 'talos', 14:43:06 INFO - 'log_to_console': True, 14:43:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:43:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:43:06 INFO - 'opt_config_files': (), 14:43:06 INFO - 'pip_index': False, 14:43:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:43:06 INFO - 'cmd': ('bash', 14:43:06 INFO - '-c', 14:43:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:43:06 INFO - 'enabled': True, 14:43:06 INFO - 'halt_on_failure': False, 14:43:06 INFO - 'name': 'check_screen_resolution'},), 14:43:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:43:06 INFO - 'cmd': ('bash', 14:43:06 INFO - '-c', 14:43:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:43:06 INFO - 'enabled': True, 14:43:06 INFO - 'halt_on_failure': False, 14:43:06 INFO - 'name': 'check_screen_resolution'},), 14:43:06 INFO - 'run_cmd_checks_enabled': True, 14:43:06 INFO - 'sps_profile': False, 14:43:06 INFO - 'sps_profile_interval': 0, 14:43:06 INFO - 'suite': 'dromaeojs-e10s', 14:43:06 INFO - 'system_bits': '32', 14:43:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:43:06 INFO - 'title': 't-yosemite-r7-0325', 14:43:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:43:06 INFO - 'use_talos_json': True, 14:43:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:43:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:43:06 INFO - 'work_dir': 'build'} 14:43:06 INFO - [mozharness: 2016-10-04 21:43:06.803047Z] Running clobber step. 14:43:06 INFO - Running pre-action listener: _resource_record_pre_action 14:43:06 INFO - Running main action method: clobber 14:43:06 INFO - rmtree: /builds/slave/test/build 14:43:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:43:09 INFO - Running post-action listener: _resource_record_post_action 14:43:09 INFO - [mozharness: 2016-10-04 21:43:09.019901Z] Finished clobber step (success) 14:43:09 INFO - [mozharness: 2016-10-04 21:43:09.020036Z] Running read-buildbot-config step. 14:43:09 INFO - Running pre-action listener: _resource_record_pre_action 14:43:09 INFO - Running main action method: read_buildbot_config 14:43:09 INFO - Using buildbot properties: 14:43:09 INFO - { 14:43:09 INFO - "project": "", 14:43:09 INFO - "product": "firefox", 14:43:09 INFO - "script_repo_revision": "production", 14:43:09 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 14:43:09 INFO - "repository": "", 14:43:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 14:43:09 INFO - "buildid": "20161004113402", 14:43:09 INFO - "pgo_build": "False", 14:43:09 INFO - "basedir": "/builds/slave/test", 14:43:09 INFO - "buildnumber": 105, 14:43:09 INFO - "slavename": "t-yosemite-r7-0325", 14:43:09 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:43:09 INFO - "platform": "yosemite_r7", 14:43:09 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 14:43:09 INFO - "branch": "fx-team", 14:43:09 INFO - "repo_path": "integration/fx-team", 14:43:09 INFO - "revision": "ad324639bfaeba6d7be3b732295b6a27d0c54e0a", 14:43:09 INFO - "stage_platform": "macosx64", 14:43:09 INFO - "builduid": "61e0ff1d711e4a6bb1c5ec9346b695e9", 14:43:09 INFO - "slavebuilddir": "test" 14:43:09 INFO - } 14:43:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 14:43:09 INFO - Running post-action listener: _resource_record_post_action 14:43:09 INFO - [mozharness: 2016-10-04 21:43:09.023495Z] Finished read-buildbot-config step (success) 14:43:09 INFO - [mozharness: 2016-10-04 21:43:09.023632Z] Running download-and-extract step. 14:43:09 INFO - Running pre-action listener: _resource_record_pre_action 14:43:09 INFO - Running main action method: download_and_extract 14:43:09 INFO - mkdir: /builds/slave/test/build/tests 14:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:09 INFO - trying https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 14:43:09 INFO - Downloading https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/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 14:43:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/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 14:43:10 INFO - Downloaded 1199 bytes. 14:43:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:43:10 INFO - Using the following test package requirements: 14:43:10 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:43:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:10 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 14:43:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:10 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 14:43:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:10 INFO - u'jsshell-mac.zip'], 14:43:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:10 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 14:43:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:43:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:10 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 14:43:10 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:10 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 14:43:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:10 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 14:43:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:43:10 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 14:43:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:43:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:43:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:43:10 INFO - Fetch https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:43:10 INFO - Http code: 200 14:43:10 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 14:43:10 INFO - x-amz-cf-id: IZ7p6jSf81V5KVm1ismF7UbJm3JpPzH776xxhstv0Q3iJeXl0p9vOA== 14:43:10 INFO - x-amz-version-id: 9nSDuC8knI4NMv9oAS50fpvA4MIyRmFX 14:43:11 INFO - Expected file size: 16476841 14:43:11 INFO - Obtained file size: 16476841 14:43:18 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 14:43:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:43:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:43:18 INFO - Fetch https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:43:18 INFO - Http code: 200 14:43:18 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 14:43:18 INFO - x-amz-cf-id: WyRrRi8Ixwe3SxgQBeBI_Zr51RnloW3rwAl231k-Xm-t4MZUA-8TSQ== 14:43:18 INFO - x-amz-version-id: 9nSDuC8knI4NMv9oAS50fpvA4MIyRmFX 14:43:19 INFO - Expected file size: 16476841 14:43:19 INFO - Obtained file size: 16476841 14:43:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 14:43:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:43:25 INFO - Fetch https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 14:43:26 INFO - Http code: 200 14:43:26 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 14:43:26 INFO - x-amz-cf-id: 2y3Ys06QsatlPuGhJsWrHF-EDDu-m4orG6yOh5kCt5ZBu1hkWMLgyQ== 14:43:26 INFO - x-amz-version-id: kJOkadfPZw4i1C1IMYFHqO86hyeaN_uu 14:43:26 INFO - Expected file size: 14409006 14:43:26 INFO - Obtained file size: 14409006 14:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:27 INFO - trying https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:43:27 INFO - Downloading https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 14:43:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/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 14:43:29 INFO - Downloaded 111607262 bytes. 14:43:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:43:29 INFO - mkdir: /builds/slave/test/properties 14:43:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:43:29 INFO - Writing to file /builds/slave/test/properties/build_url 14:43:29 INFO - Contents: 14:43:29 INFO - build_url:https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:43:30 INFO - Running post-action listener: _resource_record_post_action 14:43:30 INFO - Running post-action listener: set_extra_try_arguments 14:43:30 INFO - [mozharness: 2016-10-04 21:43:30.651171Z] Finished download-and-extract step (success) 14:43:30 INFO - [mozharness: 2016-10-04 21:43:30.651264Z] Running populate-webroot step. 14:43:30 INFO - Running pre-action listener: _resource_record_pre_action 14:43:30 INFO - Running main action method: populate_webroot 14:43:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:43:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:43:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:43:30 INFO - '--tppagecycles', 14:43:30 INFO - '7'], 14:43:30 INFO - 'tests': ['tsvgm']}}, 14:43:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:43:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:43:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:43:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:43:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:43:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:43:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:30 INFO - 'talos_options': ['--disable-e10s'], 14:43:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:43:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:43:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:30 INFO - 'talos_options': ['--disable-e10s'], 14:43:30 INFO - 'tests': ['damp', 'tps']}, 14:43:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:30 INFO - 'tests': ['damp', 'tps']}, 14:43:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:43:30 INFO - 'tests': ['dromaeo_dom']}, 14:43:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:43:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:43:30 INFO - 'tests': ['basic_compositor_video']}, 14:43:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:43:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:43:30 INFO - 'tests': ['a11yr', 14:43:30 INFO - 'ts_paint', 14:43:30 INFO - 'tpaint', 14:43:30 INFO - 'sessionrestore', 14:43:30 INFO - 'sessionrestore_no_auto_restore', 14:43:30 INFO - 'tabpaint']}, 14:43:30 INFO - 'other-e10s': {'tests': ['a11yr', 14:43:30 INFO - 'ts_paint', 14:43:30 INFO - 'tpaint', 14:43:30 INFO - 'sessionrestore', 14:43:30 INFO - 'sessionrestore_no_auto_restore', 14:43:30 INFO - 'tabpaint']}, 14:43:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:43:30 INFO - 'ts_paint', 14:43:30 INFO - 'tpaint', 14:43:30 INFO - 'sessionrestore', 14:43:30 INFO - 'sessionrestore_no_auto_restore', 14:43:30 INFO - 'tabpaint']}, 14:43:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:43:30 INFO - 'ts_paint', 14:43:30 INFO - 'tpaint', 14:43:30 INFO - 'sessionrestore', 14:43:30 INFO - 'sessionrestore_no_auto_restore', 14:43:30 INFO - 'tabpaint']}, 14:43:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:43:30 INFO - 'tests': ['a11yr', 14:43:30 INFO - 'ts_paint', 14:43:30 INFO - 'tpaint', 14:43:30 INFO - 'sessionrestore', 14:43:30 INFO - 'sessionrestore_no_auto_restore', 14:43:30 INFO - 'tabpaint']}, 14:43:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:43:30 INFO - 'tests': ['a11yr', 14:43:30 INFO - 'ts_paint', 14:43:30 INFO - 'tpaint', 14:43:30 INFO - 'sessionrestore', 14:43:30 INFO - 'sessionrestore_no_auto_restore', 14:43:30 INFO - 'tabpaint']}, 14:43:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:43:30 INFO - 'tests': ['tsvgx', 14:43:30 INFO - 'tsvgr_opacity', 14:43:30 INFO - 'tart', 14:43:30 INFO - 'tscrollx', 14:43:30 INFO - 'cart']}, 14:43:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:43:30 INFO - 'tsvgr_opacity', 14:43:30 INFO - 'tart', 14:43:30 INFO - 'tscrollx', 14:43:30 INFO - 'cart']}, 14:43:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:30 INFO - 'talos_options': ['--disable-e10s'], 14:43:30 INFO - 'tests': ['tp5o']}, 14:43:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:30 INFO - 'tests': ['tp5o']}, 14:43:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:30 INFO - 'talos_options': ['--disable-e10s', 14:43:30 INFO - '--xperf_path', 14:43:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:43:30 INFO - 'tests': ['tp5n']}, 14:43:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:30 INFO - 'talos_options': ['--xperf_path', 14:43:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:43:30 INFO - 'tests': ['tp5n']}}, 14:43:30 INFO - 'talos.zip': {'path': '', 14:43:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:43:30 INFO - Running post-action listener: _resource_record_post_action 14:43:30 INFO - [mozharness: 2016-10-04 21:43:30.670263Z] Finished populate-webroot step (success) 14:43:30 INFO - [mozharness: 2016-10-04 21:43:30.670394Z] Running create-virtualenv step. 14:43:30 INFO - Running pre-action listener: _resource_record_pre_action 14:43:30 INFO - Running main action method: create_virtualenv 14:43:30 INFO - Creating virtualenv /builds/slave/test/build/venv 14:43:30 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 14:43:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:43:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:43:30 INFO - Using real prefix '/tools/python27' 14:43:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:43:31 INFO - Installing distribute.............................................................................................................................................................................................done. 14:43:34 INFO - Installing pip.................done. 14:43:34 INFO - Return code: 0 14:43:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:43:34 INFO - Reading from file tmpfile_stdout 14:43:34 INFO - Output received: 14:43:34 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) 14:43:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:43:34 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')]} 14:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:34 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')]} 14:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:34 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 0x100803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da2f05de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100617d30>, '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 0x10043ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10060fb20>, '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.bL77nRpOvF/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.i5goNQsdu4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 14:43:34 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 14:43:34 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 14:43:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bL77nRpOvF/Render', 14:43:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:34 INFO - 'HOME': '/Users/cltbld', 14:43:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:34 INFO - 'LOGNAME': 'cltbld', 14:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:34 INFO - 'MOZ_NO_REMOTE': '1', 14:43:34 INFO - 'NO_EM_RESTART': '1', 14:43:34 INFO - 'PAGER': '/bin/cat', 14:43:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:34 INFO - 'PWD': '/builds/slave/test', 14:43:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:34 INFO - 'SHELL': '/bin/bash', 14:43:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5goNQsdu4/Listeners', 14:43:34 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 14:43:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:34 INFO - 'USER': 'cltbld', 14:43:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:34 INFO - 'XPC_FLAGS': '0x0', 14:43:34 INFO - 'XPC_SERVICE_NAME': '0', 14:43:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:34 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 14:43:34 INFO - Cleaning up... 14:43:34 INFO - Return code: 0 14:43:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:43:34 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')]} 14:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:34 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')]} 14:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:34 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 0x100803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da2f05de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100617d30>, '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 0x10043ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10060fb20>, '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.bL77nRpOvF/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.i5goNQsdu4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 14:43:34 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 14:43:34 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 14:43:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bL77nRpOvF/Render', 14:43:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:34 INFO - 'HOME': '/Users/cltbld', 14:43:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:34 INFO - 'LOGNAME': 'cltbld', 14:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:34 INFO - 'MOZ_NO_REMOTE': '1', 14:43:34 INFO - 'NO_EM_RESTART': '1', 14:43:34 INFO - 'PAGER': '/bin/cat', 14:43:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:34 INFO - 'PWD': '/builds/slave/test', 14:43:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:34 INFO - 'SHELL': '/bin/bash', 14:43:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5goNQsdu4/Listeners', 14:43:34 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 14:43:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:34 INFO - 'USER': 'cltbld', 14:43:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:34 INFO - 'XPC_FLAGS': '0x0', 14:43:34 INFO - 'XPC_SERVICE_NAME': '0', 14:43:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:35 INFO - Downloading/unpacking psutil>=3.1.1 14:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:43:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:43:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:43:38 INFO - Installing collected packages: psutil 14:43:38 INFO - Running setup.py install for psutil 14:43:38 INFO - building 'psutil._psutil_osx' extension 14:43:38 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 14:43:39 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 14:43:39 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 14:43:39 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 14:43:39 INFO - building 'psutil._psutil_posix' extension 14:43:39 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 14:43:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:43:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:43:39 INFO - ^ 14:43:39 INFO - 1 warning generated. 14:43:39 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 14:43:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:43:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:43:39 INFO - Successfully installed psutil 14:43:39 INFO - Cleaning up... 14:43:39 INFO - Return code: 0 14:43:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da2f05de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100617d30>, '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 0x10043ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10060fb20>, '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.bL77nRpOvF/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.i5goNQsdu4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 14:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:43:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bL77nRpOvF/Render', 14:43:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:39 INFO - 'HOME': '/Users/cltbld', 14:43:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:39 INFO - 'LOGNAME': 'cltbld', 14:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:39 INFO - 'MOZ_NO_REMOTE': '1', 14:43:39 INFO - 'NO_EM_RESTART': '1', 14:43:39 INFO - 'PAGER': '/bin/cat', 14:43:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:39 INFO - 'PWD': '/builds/slave/test', 14:43:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:39 INFO - 'SHELL': '/bin/bash', 14:43:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5goNQsdu4/Listeners', 14:43:39 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 14:43:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:39 INFO - 'USER': 'cltbld', 14:43:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:39 INFO - 'XPC_FLAGS': '0x0', 14:43:39 INFO - 'XPC_SERVICE_NAME': '0', 14:43:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:43:39 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 14:43:39 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 14:43:39 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 14:43:39 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 14:43:39 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 14:43:39 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 14:43:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:43:42 INFO - Installing collected packages: mozsystemmonitor 14:43:42 INFO - Running setup.py install for mozsystemmonitor 14:43:42 INFO - Successfully installed mozsystemmonitor 14:43:42 INFO - Cleaning up... 14:43:42 INFO - Return code: 0 14:43:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:43:42 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')]} 14:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:42 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')]} 14:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:42 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 0x100803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da2f05de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100617d30>, '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 0x10043ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10060fb20>, '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.bL77nRpOvF/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.i5goNQsdu4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 14:43:42 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 14:43:42 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 14:43:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bL77nRpOvF/Render', 14:43:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:42 INFO - 'HOME': '/Users/cltbld', 14:43:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:42 INFO - 'LOGNAME': 'cltbld', 14:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:42 INFO - 'MOZ_NO_REMOTE': '1', 14:43:42 INFO - 'NO_EM_RESTART': '1', 14:43:42 INFO - 'PAGER': '/bin/cat', 14:43:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:42 INFO - 'PWD': '/builds/slave/test', 14:43:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:42 INFO - 'SHELL': '/bin/bash', 14:43:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5goNQsdu4/Listeners', 14:43:42 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 14:43:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:42 INFO - 'USER': 'cltbld', 14:43:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:42 INFO - 'XPC_FLAGS': '0x0', 14:43:42 INFO - 'XPC_SERVICE_NAME': '0', 14:43:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:42 INFO - Downloading/unpacking jsonschema==2.5.1 14:43:42 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 14:43:42 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 14:43:42 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 14:43:42 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 14:43:42 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 14:43:42 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 14:43:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:43:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:43:45 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 14:43:45 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 14:43:45 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 14:43:45 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 14:43:45 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 14:43:45 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 14:43:45 INFO - Downloading functools32-3.2.3-2.tar.gz 14:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:43:45 INFO - warning: no files found matching '*.txt' 14:43:45 INFO - no previously-included directories found matching 'build' 14:43:45 INFO - no previously-included directories found matching 'dist' 14:43:45 INFO - no previously-included directories found matching '.git*' 14:43:45 INFO - Installing collected packages: jsonschema, functools32 14:43:45 INFO - Running setup.py install for functools32 14:43:45 INFO - warning: no files found matching '*.txt' 14:43:45 INFO - no previously-included directories found matching 'build' 14:43:46 INFO - no previously-included directories found matching 'dist' 14:43:46 INFO - no previously-included directories found matching '.git*' 14:43:46 INFO - Successfully installed jsonschema functools32 14:43:46 INFO - Cleaning up... 14:43:46 INFO - Return code: 0 14:43:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:46 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 0x100803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da2f05de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100617d30>, '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 0x10043ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10060fb20>, '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.bL77nRpOvF/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.i5goNQsdu4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 14:43:46 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 14:43:46 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 14:43:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bL77nRpOvF/Render', 14:43:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:46 INFO - 'HOME': '/Users/cltbld', 14:43:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:46 INFO - 'LOGNAME': 'cltbld', 14:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:46 INFO - 'MOZ_NO_REMOTE': '1', 14:43:46 INFO - 'NO_EM_RESTART': '1', 14:43:46 INFO - 'PAGER': '/bin/cat', 14:43:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:46 INFO - 'PWD': '/builds/slave/test', 14:43:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:46 INFO - 'SHELL': '/bin/bash', 14:43:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5goNQsdu4/Listeners', 14:43:46 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 14:43:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:46 INFO - 'USER': 'cltbld', 14:43:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:46 INFO - 'XPC_FLAGS': '0x0', 14:43:46 INFO - 'XPC_SERVICE_NAME': '0', 14:43:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:43:46 INFO - Cleaning up... 14:43:46 INFO - Return code: 0 14:43:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:46 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 0x100803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da2f05de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100617d30>, '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 0x10043ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10060fb20>, '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.bL77nRpOvF/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.i5goNQsdu4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 14:43:46 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 14:43:46 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 14:43:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bL77nRpOvF/Render', 14:43:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:46 INFO - 'HOME': '/Users/cltbld', 14:43:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:46 INFO - 'LOGNAME': 'cltbld', 14:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:46 INFO - 'MOZ_NO_REMOTE': '1', 14:43:46 INFO - 'NO_EM_RESTART': '1', 14:43:46 INFO - 'PAGER': '/bin/cat', 14:43:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:46 INFO - 'PWD': '/builds/slave/test', 14:43:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:46 INFO - 'SHELL': '/bin/bash', 14:43:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5goNQsdu4/Listeners', 14:43:46 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 14:43:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:46 INFO - 'USER': 'cltbld', 14:43:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:46 INFO - 'XPC_FLAGS': '0x0', 14:43:46 INFO - 'XPC_SERVICE_NAME': '0', 14:43:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:46 INFO - Downloading/unpacking blobuploader==1.2.4 14:43:46 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 14:43:46 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 14:43:46 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 14:43:46 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 14:43:46 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 14:43:46 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 14:43:49 INFO - Downloading blobuploader-1.2.4.tar.gz 14:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:43:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:43:49 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 14:43:49 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 14:43:49 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 14:43:49 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 14:43:49 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 14:43:49 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 14:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:43:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:43:49 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 14:43:49 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 14:43:49 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 14:43:49 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 14:43:49 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 14:43:49 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 14:43:50 INFO - Downloading docopt-0.6.1.tar.gz 14:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:43:50 INFO - Installing collected packages: blobuploader, requests, docopt 14:43:50 INFO - Running setup.py install for blobuploader 14:43:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:43:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:43:50 INFO - Running setup.py install for requests 14:43:50 INFO - Running setup.py install for docopt 14:43:51 INFO - Successfully installed blobuploader requests docopt 14:43:51 INFO - Cleaning up... 14:43:51 INFO - Return code: 0 14:43:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:51 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')]} 14:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:51 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')]} 14:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:51 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 0x100803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da2f05de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100617d30>, '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 0x10043ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10060fb20>, '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.bL77nRpOvF/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.i5goNQsdu4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 14:43:51 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 14:43:51 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 14:43:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bL77nRpOvF/Render', 14:43:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:51 INFO - 'HOME': '/Users/cltbld', 14:43:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:51 INFO - 'LOGNAME': 'cltbld', 14:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:51 INFO - 'MOZ_NO_REMOTE': '1', 14:43:51 INFO - 'NO_EM_RESTART': '1', 14:43:51 INFO - 'PAGER': '/bin/cat', 14:43:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:51 INFO - 'PWD': '/builds/slave/test', 14:43:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:51 INFO - 'SHELL': '/bin/bash', 14:43:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5goNQsdu4/Listeners', 14:43:51 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 14:43:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:51 INFO - 'USER': 'cltbld', 14:43:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:51 INFO - 'XPC_FLAGS': '0x0', 14:43:51 INFO - 'XPC_SERVICE_NAME': '0', 14:43:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:43:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-lUAfxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:43:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-83P32P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:43:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-SwXK9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:43:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-etGv2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:43:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-OiQiYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:43:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-c2nEE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:43:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-rUTdEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:43:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Zhbb3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:43:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-UQqEqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:43:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-ATpOIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:43:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-_2rLak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:43:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-GW6LBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:43:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-pOtMXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:43:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-J9NVag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-29OfuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:43:53 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-caoWaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:43:53 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Va19gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:43:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:43:53 INFO - Running setup.py install for manifestparser 14:43:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:43:53 INFO - Running setup.py install for mozcrash 14:43:53 INFO - Running setup.py install for mozdebug 14:43:53 INFO - Running setup.py install for mozdevice 14:43:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:43:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:43:53 INFO - Running setup.py install for mozfile 14:43:54 INFO - Running setup.py install for mozhttpd 14:43:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:43:54 INFO - Running setup.py install for mozinfo 14:43:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:43:54 INFO - Running setup.py install for mozInstall 14:43:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:43:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:43:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:43:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:43:54 INFO - Running setup.py install for mozleak 14:43:54 INFO - Running setup.py install for mozlog 14:43:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:43:54 INFO - Running setup.py install for moznetwork 14:43:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:43:54 INFO - Running setup.py install for mozprocess 14:43:55 INFO - Running setup.py install for mozprofile 14:43:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:43:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:43:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:43:55 INFO - Running setup.py install for mozrunner 14:43:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:43:55 INFO - Running setup.py install for mozscreenshot 14:43:55 INFO - Running setup.py install for moztest 14:43:55 INFO - Running setup.py install for mozversion 14:43:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:43:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:43:55 INFO - Cleaning up... 14:43:55 INFO - Return code: 0 14:43:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:55 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')]} 14:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:55 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')]} 14:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:55 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 0x100803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da2f05de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100617d30>, '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 0x10043ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10060fb20>, '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.bL77nRpOvF/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.i5goNQsdu4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 14:43:55 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 14:43:55 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 14:43:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bL77nRpOvF/Render', 14:43:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:43:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:43:55 INFO - 'HOME': '/Users/cltbld', 14:43:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:43:55 INFO - 'LOGNAME': 'cltbld', 14:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:55 INFO - 'MOZ_NO_REMOTE': '1', 14:43:55 INFO - 'NO_EM_RESTART': '1', 14:43:55 INFO - 'PAGER': '/bin/cat', 14:43:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:55 INFO - 'PWD': '/builds/slave/test', 14:43:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:43:55 INFO - 'SHELL': '/bin/bash', 14:43:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5goNQsdu4/Listeners', 14:43:55 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 14:43:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:43:55 INFO - 'USER': 'cltbld', 14:43:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:43:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:55 INFO - 'XPC_FLAGS': '0x0', 14:43:55 INFO - 'XPC_SERVICE_NAME': '0', 14:43:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:43:56 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-wbRHFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:43:56 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)) 14:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:43:56 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-EkZtlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:43:56 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)) 14:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:43:56 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Y2SWzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:43:56 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)) 14:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:43:56 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-XOTzHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:43:56 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)) 14:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:43:56 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-CVcJgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:43:56 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)) 14:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:43:56 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-3XVmqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:43:56 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)) 14:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:43:56 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-gFE5qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:43:56 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)) 14:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:43:56 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-79B5dI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:43:56 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)) 14:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:43:56 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-319RHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:43:57 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)) 14:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:43:57 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-aMNeFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:43:57 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)) 14:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:43:57 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-60bCPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:43:57 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)) 14:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:43:57 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-jujfTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:43:57 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)) 14:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:43:57 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-wewP6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:43:57 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)) 14:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:43:57 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-vD7SEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:43:57 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)) 14:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:57 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Z_MAmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:57 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)) 14:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:43:57 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-I3yy10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:43:57 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)) 14:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:43:57 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-YFmLwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:43:57 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)) 14:43:57 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)) 14:43:57 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)) 14:43:57 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)) 14:43:57 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)) 14:43:57 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)) 14:43:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:43:57 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 14:43:57 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 14:43:57 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 14:43:57 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 14:43:57 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 14:43:57 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 14:44:00 INFO - Downloading blessings-1.6.tar.gz 14:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:44:00 INFO - Installing collected packages: blessings 14:44:00 INFO - Running setup.py install for blessings 14:44:00 INFO - Successfully installed blessings 14:44:00 INFO - Cleaning up... 14:44:00 INFO - Return code: 0 14:44:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:44:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:44:01 INFO - Reading from file tmpfile_stdout 14:44:01 INFO - Current package versions: 14:44:01 INFO - blessings == 1.6 14:44:01 INFO - blobuploader == 1.2.4 14:44:01 INFO - docopt == 0.6.1 14:44:01 INFO - functools32 == 3.2.3-2 14:44:01 INFO - jsonschema == 2.5.1 14:44:01 INFO - manifestparser == 1.1 14:44:01 INFO - mozInstall == 1.12 14:44:01 INFO - mozcrash == 0.17 14:44:01 INFO - mozdebug == 0.1 14:44:01 INFO - mozdevice == 0.48 14:44:01 INFO - mozfile == 1.2 14:44:01 INFO - mozhttpd == 0.7 14:44:01 INFO - mozinfo == 0.9 14:44:01 INFO - mozleak == 0.1 14:44:01 INFO - mozlog == 3.4 14:44:01 INFO - moznetwork == 0.27 14:44:01 INFO - mozprocess == 0.23 14:44:01 INFO - mozprofile == 0.28 14:44:01 INFO - mozrunner == 6.12 14:44:01 INFO - mozscreenshot == 0.1 14:44:01 INFO - mozsystemmonitor == 0.3 14:44:01 INFO - moztest == 0.7 14:44:01 INFO - mozversion == 1.4 14:44:01 INFO - psutil == 3.1.1 14:44:01 INFO - requests == 1.2.3 14:44:01 INFO - wsgiref == 0.1.2 14:44:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:01 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 0x100803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da2f05de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100617d30>, '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 0x10043ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10060fb20>, '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.bL77nRpOvF/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.i5goNQsdu4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 14:44:01 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 14:44:01 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 14:44:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bL77nRpOvF/Render', 14:44:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:01 INFO - 'HOME': '/Users/cltbld', 14:44:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:01 INFO - 'LOGNAME': 'cltbld', 14:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:01 INFO - 'MOZ_NO_REMOTE': '1', 14:44:01 INFO - 'NO_EM_RESTART': '1', 14:44:01 INFO - 'PAGER': '/bin/cat', 14:44:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:01 INFO - 'PWD': '/builds/slave/test', 14:44:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:01 INFO - 'SHELL': '/bin/bash', 14:44:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5goNQsdu4/Listeners', 14:44:01 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 14:44:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:01 INFO - 'USER': 'cltbld', 14:44:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:01 INFO - 'XPC_FLAGS': '0x0', 14:44:01 INFO - 'XPC_SERVICE_NAME': '0', 14:44:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:01 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)) 14:44:01 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)) 14:44:01 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)) 14:44:01 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)) 14:44:01 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)) 14:44:01 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)) 14:44:01 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)) 14:44:01 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)) 14:44:01 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)) 14:44:01 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)) 14:44:01 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)) 14:44:01 INFO - Cleaning up... 14:44:01 INFO - Return code: 0 14:44:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:02 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 0x100803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9da2f05de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100617d30>, '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 0x10043ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10060fb20>, '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.bL77nRpOvF/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.i5goNQsdu4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 14:44:02 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 14:44:02 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 14:44:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bL77nRpOvF/Render', 14:44:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:02 INFO - 'HOME': '/Users/cltbld', 14:44:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:02 INFO - 'LOGNAME': 'cltbld', 14:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:02 INFO - 'MOZ_NO_REMOTE': '1', 14:44:02 INFO - 'NO_EM_RESTART': '1', 14:44:02 INFO - 'PAGER': '/bin/cat', 14:44:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:02 INFO - 'PWD': '/builds/slave/test', 14:44:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:02 INFO - 'SHELL': '/bin/bash', 14:44:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5goNQsdu4/Listeners', 14:44:02 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 14:44:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:02 INFO - 'USER': 'cltbld', 14:44:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:02 INFO - 'XPC_FLAGS': '0x0', 14:44:02 INFO - 'XPC_SERVICE_NAME': '0', 14:44:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:44:02 INFO - Cleaning up... 14:44:02 INFO - Return code: 0 14:44:02 INFO - Running post-action listener: _resource_record_post_action 14:44:02 INFO - Running post-action listener: _start_resource_monitoring 14:44:02 INFO - Starting resource monitoring. 14:44:02 INFO - [mozharness: 2016-10-04 21:44:02.423070Z] Finished create-virtualenv step (success) 14:44:02 INFO - [mozharness: 2016-10-04 21:44:02.424065Z] Running install step. 14:44:02 INFO - Running pre-action listener: _resource_record_pre_action 14:44:02 INFO - Running main action method: install 14:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:44:02 INFO - Reading from file tmpfile_stdout 14:44:02 INFO - Detecting whether we're running mozinstall >=1.0... 14:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:44:02 INFO - Reading from file tmpfile_stdout 14:44:02 INFO - Output received: 14:44:02 INFO - Usage: mozinstall [options] installer 14:44:02 INFO - Options: 14:44:02 INFO - -h, --help show this help message and exit 14:44:02 INFO - -d DEST, --destination=DEST 14:44:02 INFO - Directory to install application into. [default: 14:44:02 INFO - "/builds/slave/test"] 14:44:02 INFO - --app=APP Application being installed. [default: firefox] 14:44:02 INFO - mkdir: /builds/slave/test/build/application 14:44:02 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'] 14:44:02 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 14:44:37 INFO - Reading from file tmpfile_stdout 14:44:37 INFO - Output received: 14:44:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:44:37 INFO - Running post-action listener: _resource_record_post_action 14:44:37 INFO - [mozharness: 2016-10-04 21:44:37.912909Z] Finished install step (success) 14:44:37 INFO - [mozharness: 2016-10-04 21:44:37.913082Z] Running run-tests step. 14:44:37 INFO - Running pre-action listener: _resource_record_pre_action 14:44:37 INFO - Running main action method: run_tests 14:44:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:44:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:44:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:44:37 INFO - 2016-10-04 14:44:37.927 screenresolution[1646:7611] starting screenresolution argv=screenresolution get 14:44:37 INFO - 2016-10-04 14:44:37.930 screenresolution[1646:7611] Display 0: 1600x1200x32@60 14:44:37 INFO - 2016-10-04 14:44:37.935 screenresolution[1647:7613] starting screenresolution argv=screenresolution list 14:44:37 INFO - Available Modes on Display 0 14:44:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:44:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:44:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:44:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:44:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:44:38 INFO - Intel Iris: 14:44:38 INFO - Chipset Model: Intel Iris 14:44:38 INFO - Type: GPU 14:44:38 INFO - Bus: Built-In 14:44:38 INFO - VRAM (Dynamic, Max): 1536 MB 14:44:38 INFO - Vendor: Intel (0x8086) 14:44:38 INFO - Device ID: 0x0a2e 14:44:38 INFO - Revision ID: 0x0009 14:44:38 INFO - Displays: 14:44:38 INFO - Display: 14:44:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:44:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:44:38 INFO - Display Serial Number: 1600x1200 60 14:44:38 INFO - Main Display: Yes 14:44:38 INFO - Mirror: Off 14:44:38 INFO - Online: Yes 14:44:38 INFO - Rotation: Supported 14:44:38 INFO - Return code: 0 14:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:44:38 INFO - Python 2.7.3 14:44:38 INFO - Return code: 0 14:44:38 INFO - grabbing minidump binary from tooltool 14:44: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')]} 14:44:38 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 0x100617d30>, '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 0x10043ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10060fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:44:38 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 14:44:38 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 14:44:38 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 14:44:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:44:38 INFO - Return code: 0 14:44:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:44:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:44:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:44:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:44:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0325', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0325 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bL77nRpOvF/Render', 14:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:38 INFO - 'HOME': '/Users/cltbld', 14:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:38 INFO - 'LOGNAME': 'cltbld', 14:44:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:44:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:38 INFO - 'MOZ_NO_REMOTE': '1', 14:44:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:44:38 INFO - 'NO_EM_RESTART': '1', 14:44:38 INFO - 'PAGER': '/bin/cat', 14:44:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:38 INFO - 'PWD': '/builds/slave/test', 14:44:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:38 INFO - 'SHELL': '/bin/bash', 14:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5goNQsdu4/Listeners', 14:44:38 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 14:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:38 INFO - 'USER': 'cltbld', 14:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:38 INFO - 'XPC_FLAGS': '0x0', 14:44:38 INFO - 'XPC_SERVICE_NAME': '0', 14:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0325', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:44:38 INFO - mozversion application_buildid: 20161004113402 14:44:38 INFO - mozversion application_changeset: ad324639bfaeba6d7be3b732295b6a27d0c54e0a 14:44:38 INFO - mozversion application_display_name: Nightly 14:44:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:44:38 INFO - mozversion application_name: Firefox 14:44:38 INFO - mozversion application_remotingname: firefox 14:44:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:44:38 INFO - mozversion application_vendor: Mozilla 14:44:38 INFO - mozversion application_version: 52.0a1 14:44:38 INFO - mozversion platform_buildid: 20161004113402 14:44:38 INFO - mozversion platform_changeset: ad324639bfaeba6d7be3b732295b6a27d0c54e0a 14:44:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:44:38 INFO - mozversion platform_version: 52.0a1 14:44:38 INFO - using testdate: 1475617478 14:44:38 INFO - actual date: 1475617478 14:44:38 INFO - starting webserver on 'localhost:49279' 14:44:38 INFO - SUITE-START | Running 2 tests 14:44:38 INFO - TEST-START | dromaeo_css 14:44:38 INFO - operating with platform_type : mac_ 14:44:38 INFO - Initialising browser for dromaeo_css test... 14:44:38 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmpk5ZP0E/profile http://localhost:49279/getInfo.html) 14:44:41 INFO - PROCESS | 1657 | 2016-10-04 14:44:41.474 plugin-container[1662:7839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 14:44:41 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:44:41 INFO - PROCESS | 1657 | 2016-10-04 14:44:41.477 plugin-container[1662:7839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940f, name = 'com.apple.CFPasteboardClient' 14:44:41 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:44:41 INFO - PROCESS | 1657 | 2016-10-04 14:44:41.477 plugin-container[1662:7839] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:44:41 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 14:44:41 INFO - PROCESS | 1657 | colorDepth:24 14:44:41 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 14:44:41 INFO - PROCESS | 1657 | __metrics 14:44:41 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 14:44:42 INFO - TEST-INFO | 1657: exit 0 14:44:42 INFO - Browser initialized. 14:44:42 INFO - Running cycle 1/1 for dromaeo_css test... 14:44:42 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmpk5ZP0E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:44 INFO - PROCESS | 1663 | 2016-10-04 14:44:44.489 plugin-container[1664:7959] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.tsm.portname' 14:44:44 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:44:44 INFO - PROCESS | 1663 | 2016-10-04 14:44:44.492 plugin-container[1664:7959] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 14:44:44 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:44:44 INFO - PROCESS | 1663 | 2016-10-04 14:44:44.492 plugin-container[1664:7959] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:44:54 INFO - PROCESS | 1663 | RSS: Main: 240152576 14:44:54 INFO - PROCESS | 1663 | 14:45:43 INFO - PROCESS | 1663 | 1475617543854 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] 14:47:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 14:47:58 INFO - PROCESS | 1663 | RSS: Main: 253767680 14:47:58 INFO - PROCESS | 1663 | 14:51:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 14:51:01 INFO - PROCESS | 1663 | RSS: Main: 267329536 14:51:01 INFO - PROCESS | 1663 | 14:54:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 14:54:03 INFO - PROCESS | 1663 | RSS: Main: 270331904 14:54:03 INFO - PROCESS | 1663 | 14:57:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 14:57:06 INFO - PROCESS | 1663 | RSS: Main: 271036416 14:57:06 INFO - PROCESS | 1663 | 15:00:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 15:00:09 INFO - PROCESS | 1663 | RSS: Main: 275501056 15:00:09 INFO - PROCESS | 1663 | 15:03:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 15:03:12 INFO - PROCESS | 1663 | RSS: Main: 278224896 15:03:12 INFO - PROCESS | 1663 | 15:03:12 INFO - PROCESS | 1663 | __start_tp_report 15:03:12 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 15:03:12 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 15:03:12 INFO - PROCESS | 1663 | |i|pagename|runs| 15:03:12 INFO - PROCESS | 1663 | |0;dojo.html;3356.4126277901364;3361.0925050236438;3397.7621566490325;3397.7791443556175;3401.4557670772665;5247.763850626721;5608.971955140219;5653;5745.023346031175;5755.712214389285;5655;5732.5127364173995;5767.596268261213;5774.797882074128;5776.682282474462;5128.948710512894;5187.48125187482;5209.557187639036;5225.294585230983;5240.816571420001;5189.221616757479;5266.81566145185;5270;5292.523672869441;5296.973515132419;5104.668196567211;5224.059669259532;5250.7112108834;5256.947430525704;5350.652207606513;5108.978204359143;5151.5878729701535;5156.04613146569;5197.350331208599;5266.052110620087;4308.879691280258;4532.161550113239;5128;5151.098557752416;5155.845324640267;4222.155568886235;4244.236037513247;4862.343583616202;5712.914306285367;5719.7140142992685;6071.332153463116;6085.878282434326;6144.416280453394;6152.600080994721;6157.815265541996;5923.881522369528;6204.317525072239;6219.937800621981;6243.906341404882;6261.561690681654;5819.214406055128;5821.825345239649;5828.950788857961;5832.12518122285;5864.853378665525;6111.95640283616;6126.792505495304;6128.717018009172;6219.1604133442315;6250.062490626351;6065.4541091302;6112.26032301701;6118;6121.96939015311;6145.586515101462;6161.3259229064115;6172.506199504029;6203.7828675996125;6213.254409470893;6234;6028.186194863725;6050.818475445743;6102.822530595962;6135.325114237519;6136.21274067861;6187.133801267826;6232.439080482778;6240.812775616739;6247.968760156261;6295.3389894060465;4900.681455705368;4915.705057696549;4923.138450771101;4935.531124543163;4937.1113199624415;3324.750643701732;4372.584604462571;4389.363542286351;4442.178197033559;4462.977685111554;5809.535237181015;5818.6217895836635;5834.38738932406;5863.442972917566;5921.73352199152;6214.130021796952;6234.407731265523;6237.313895471494;6258.74965001404;6262.12330273762;5650.180723795109;5793.536517078624;5837.532997360201;5873.500752436091;5891.49922256613;5304.469553044664;5322.654027488201;5348.171033489815;5359.919601205985;5393.110136827379;6237.313895471585;6240.656763878031;6242.219722534684;6245.250569931637;6247.219097612799;6119.015143218386;6207.16203312547;6227.595206311576;6235.657038862906;6241.625502469685;6127.1589861177945;6136.151476879544;6158.445739883432;6172.475339596005;6251.187345645037;6071.51427885777;6135.263768347827;6136.846578835565;6140.785072522441;6148.262208535004;5045.394552653705;6225;6253.812385628438;6261.123442717932;6262.561620686508;5649.096144616841;5792.652440853562;6057.515398768176;6085.208922840003;6110.7106460192745;6129.572745043327;6132.478739307209;6141.986572215713;6148.292946311231;6148.877022459436;4729.929051064168;5460.126379779216;5843.532517398683;5991.131285963598;5993.130996005642;6079.3312735598165;6093.238345206849;6133.601315914451;6136.243373036893;6140.84169297792;5989.760409583568;6029.577929545065;6031.36670649593;6041.546883983631;6044.486218671286 15:03:12 INFO - PROCESS | 1663 | |1;ext.html;505.9822906198283;522.644601670864;528.2261486921659;553.9806106786264;561.9912257497792;29817.403651926976;39743.60256397435;39891.20217595647;39904.60095399045;39926;40491.79754101225;40928.59071409285;40948;41000.02999490086;41010;8344.749657510254;8791.252743516809;9276.907230927673;9727.659531916384;9741.512924353789;8488.618012189467;8944.83717116774;9531.523423828816;9773.657921972732;9821.263405244636;8519.74440766775;8624;9768.413895166277;9778.657746978857;9787.265955053399;8542.658293668246;9787.706368808947;9795.804083918281;9817.901820981806;9821.066998635119;9683.709488715349;9776.16902563283;9796.706098817047;9803.31376803624;9819.116279534876;38732.031699207466;38748.80625596882;39049.21901561981;39063.60936390628;39115;3278.1506338553318;3418.3334249821046;3427.2974040321924;3465.1337165708574;3798.487204227449;30477.695223047707;30872.228194295098;31032.53451198234;31558.526622100686;31637.84181079103;3205.5031470122167;3236.951445728316;3241.222106694376;3285.78642388244;3334.366470370646;441987.79006105085;445574;445994;447515.5248447539;449082;56523.86952260932;56910.430895691345;56980.43019569834;57103.42896571064;57137.42862571404;57819;58568.70715646395;58648.706756465945;58669.70665146647;58811.70594147002;15625.531234062997;15763.605909852346;15872.285747141406;15882.205889705469;15924.283407246701;12271.509139634314;12445.62663120108;12481.500739970299;12486.687832804253;12502.3748812559;12535.43590538428;12947;13893.86106138946;14936;15009.624759381102;3208.246062175387;6070.998285282879;6183.96908015457;6244.157973397859;6271.717772700239;753.9283768042027;926.9304802139867;994.9502524873727;1009.7677534167183;1050.9579616815242;25787.484250315265;28314.168583141935;28875.855620721763;29235.976740814396;30260.54609180864;972.4748635736764;996.4270544436978;1016.537475448669;1051.358671210561;1054.5254635414094;13676.384562694702;14782.778258326134;15425.460108896135;15513.336060748203;15694.450694225647;494370.5066544028;609315;629119;636143;639803.6019639744;55937.881242374926;56009.71995139998;56105.43894561084;56287;56604;1150.6950658075616;1355.613650109714;1382.3433868911984;1384.0311781752612;1385.47352006239;28611.427771444873;29223.85388073046;29650.851745741133;30149.849250754483;30155.849220754633;47390;47429;47801.28298075462;47836.28245576389;47871.5212847881;439499;443039;449566;559291;560804;25626.871865641297;25841.870790645928;25844.741552584233;26142.085027023964;26184.34539136537;45903;46656.7667161662;46964;46964.53035469738;46982.29526557036;36634.80191188537;38095.23809523849;38164.80917595505;38519.0370240735;39084;31678.841605791822;32401.837990809894;35422.64577354193;38069.61930380772;38590.228195435375;36117.27765444729;36678.8166059168;37160.88517344484;37362.43956340711;37424.43863341997;27903.720962790114;32510.83744581262;33128.50307245441;33754.8312258447;33925.3214935695;21396.50224484271;22063;22331.218407355664;23405.79746367248;24618.753812462364 15:03:12 INFO - PROCESS | 1663 | |2;jquery.html;341.4229951382164;372.9036632301033;373.76452834714127;376.1461482434873;396.54397442940615;17509.387171449;20824.583508329823;21355.786442135573;21733.565328693436;21996.670049949265;19684;20022.099005544747;20131.396058118244;20974;21469.248576299833;5847.122931560279;5852.502537284326;6008.849778755544;6069.57512974092;6166.537509686791;4211.368294755781;4411.16187924295;5936.079907614305;6056.091586262052;6081.118237855509;5729.598928075036;6422;6685;6785.287544807798;6790.185177778649;6552.508561857856;6733.0237115617965;6752.932470675329;6758.12144421227;6771.762988295411;5792.536597072266;5828.854278643025;5832.366937257575;5852.67810270435;5864.354920958691;26132.8693356532;26221.082262120926;26235.21294361172;26313.736862631322;26512.80692368848;1863.8043005484365;2370.881455927214;2634.4599357131933;2875.4680384129;3060.8521804323377;14274;15426.691466170614;15619.765703514457;15845.366185352572;16652.58368540784;1515.4923100761148;1549.821770496396;1792.82071792821;1879.736836842843;1895;121816.56366872702;128976;129517;130184.99999999905;130573.34713326467;10097.192224622013;11034.675838899384;11366.772664546663;11581.536738530365;11603.709907252218;14434.927825360806;14482.710345793024;14505.927470362793;14595.635109122144;14622.122672639463;8544.40189186751;8619.91380086191;8632.827343453097;8694.740206556324;8738.563071846509;7090.539114957512;8383.119772423808;8507.659693612186;8655.394122411371;8664.78338041554;3788.981055094707;3824.9808750956067;3850.403187505941;4032.9596704032583;4392.209402307615;1581.2805173645963;1671.2312336325426;1909.3221906223368;1967.4392798052486;1988.2345297060735;829.3903980574273;884.38093334666;899.325505870597;924.0943875002536;932.8320902237663;20133;20865.37403877886;21261.78738212629;21423;21761.238356657443;767.7850201943464;850.336737344872;952.9190018848337;957.2437774158476;968.9951550242204;10085.949570252102;10963.671089867317;11400.48697808584;11507.88492115085;11525.810096081717;562803;584162;585046;587335;592675;136307;137293;137990.62009379777;142175;142289.28855355657;985.975350616226;990.321629683669;1014.1734486393566;1014.7818219082933;1015.7105225010837;19385.806141938963;19566.72816266938;19586.60826783485;19633.920134392745;19640.607187856447;51957.740211298704;53343;57840;57990.55023624274;58933;65273;82376.17623823925;82678.17321826705;83556.58221708852;84106;7190.137183538009;7233.348998590152;7380.114386273682;7506.061742282215;7558.58427786477;10579.31234469757;11474.311541307548;12454.25274483534;12654.873451265737;12781.48874045065;9466.810663786548;10917.945410272898;11006.394648294421;11270.211085223955;11551;10074;10369.792604148026;10713.35719856811;11211.775764484502;11363.261388009752;6170.012797952306;8580.485170889766;11484.712882178012;11507.1232191952;11708.824367634663;6974.476914231352;7287.27127287267;7354.043974283523;7365.300296471826;7522.285382888617;7369.8157546061775;9233.399829011092;11153.832692509457;11309.604163854226;11379.374134422686 15:03:12 INFO - PROCESS | 1663 | |3;mootools.html;1464.4654701034121;1551.604340893072;1644.4326707285989;1733.272025749185;1864.5245462407083;8221.753347399572;8410.495370277788;8664.566771661415;9266.814663706722;9296.90703092969;7577.924220757791;8707.216350528452;9014.504202268872;9018.188363047324;9176.265898728103;2279.133929106937;2294.4149241943283;2302.792748652621;2318.3856278086237;2318.8724620145886;2345.7067866516686;2373.027058905849;2390.6175011998084;2391.1630929174826;2398.6881705378364;2367.822413318999;2379.0245999140357;2382.475855311837;2411.9035238590436;2413.2518919135036;2364.929052128439;2379.821513386503;2386.8209884258576;2392.4138586046442;2394.042383046778;2358.6697862299293;2372.7864492195613;2375.9524809503887;2378.857268563874;2382.702162229721;8981.910180898172;9107.5446227689;9124;9157.587908544132;9189.264858811279;5316.38861530925;5482.616216864821;5488.780448782044;5492.176173573956;5502.58730595203;3529.2235708144167;3659.9268014639824;3659.963400365989;3725.329440700673;3725.776453412804;1082.76720505091;1085.2891356161726;1094.9781004379947;1097.6487523992325;1101.5703875488566;10097.798044039151;11680.591179308683;11832.290062596187;11906.1070419718;11960.222585532;4363.80362883671;4439.467263928284;4626.21354369758;4635.119327327864;4638.628909687217;9163.496007719506;9277.16505514507;9310.581023853943;9339.719808405758;9353.859692104625;4632.351470794091;5167.173252279617;5267.552258058031;5269.631125821233;5296.655717378435;4446.3552784846015;4611.976940115278;4797.376341075638;4905.6811307265625;4916.041371932439;3688.2623475305045;3695.593484716679;3786.772793632391;3800.8859734208017;3824.4072168813877;1157.583270022791;1166.9632118326506;1171.6777886081395;1173.5129921082826;1178.4166837415362;878.1438097854668;887.4409122252939;898.4878619187001;910.0399078971616;911.2436677557612;5668.319801623831;5681.914771278434;5928.347881733006;6052.788152414732;6174.938250617436;385.65291237885566;409.67635567901027;411.6994593946376;431.07534338843004;435.31655301177483;3782.1868298315994;3904.7071469639322;3938.6455219029854;3998.900027499336;4001.8399264029695;10708.875568065398;10925.836112458319;11091.33451992883;11118.054965328038;11122.054625356774;10116.848247276297;10981.890181098086;10986.890131098588;11063.059639930536;11078.279911805706;7926.48477848938;8323.95838020806;8393.412461127784;8394.580270986426;8407.201315874981;4790.880227994328;4885.755712214304;4927.9507204927495;5889.852753681193;6255.749770009149;8687.913120868963;9801.362911410735;10167.034131757471;10319.329243599143;10329.638462653771;10550.57336812522;10557.894421055691;10567.471626418803;10568.84146737815;10585.788284234119;6314;7309.817254568678;7453.291937265951;7462.701491940262;7609.353204977418;8349.666013359398;8443.366747494085;8469.195426434479;8501.064882862756;8581.871271931052;6211.9689401552705;7642.7325043623205;7643.503172293783;7670.27132422419;7693.038370203724;7285.125784905846;7444.702211911463;7477.775666730006;7500.399968002437;7518.661660225193;6974.232834388112;6982.825429364307;7073.363397294062;7074.398676112588;7078.4691148163065;4062.3297155968935;4215.430916826189;4949.554540091409;5018.623603229699;5027.170516864677;4664.763837583111;4923.163062279349;4977.228529577921;5057.721825299644;5113.053306827809 15:03:12 INFO - PROCESS | 1663 | |4;prototype.html;295.8668599130392;300.5686839385482;306.15195907336675;312.11359738343117;312.1680720878858;5286.31277933869;5505.614606977513;5515.669059856406;5569.8886022279585;5606.271184745982;5284.39229488608;5418.214358917954;5479.506844384005;5490.450954904508;5492.47821456962;4145.274576949029;4150.149219410014;4196.685248606352;4203.5376108628025;4215.40984262202;4023.6781057515473;4160.4383408239955;4164.854230101947;4193.287141185991;4198.8320467181275;3193.856276467553;3447.5690538682666;3680.1351682354625;4135.77253251071;4136.462259906208;3065.264336559232;3996.320625493673;4092.6930480213805;4148.191102734968;4165.354370072643;3583.104223944014;3622.6377362263825;3625.873094441682;3631.8365673544754;3637.8181090945345;4109.691773117028;4804.783784729696;4915.3855768029;5221.843344699665;5275.360001598884;4549.909001819979;4644.86065418038;4746.288056791474;4763.785629646674;4778.665493415462;5003.322557919926;5678.858028549319;5751.626144300607;5791.21818554494;5826.242588463472;3577.8336172487275;3633.9273214535824;3788.90527736806;3910.921781564381;3942.3889297158985;4763.737994410306;4843.636727245435;5299.178627312773;5490.890182196414;6150.815475535741;3425.5889293284467;4027.275090483741;4071.714979951434;4085.550589435219;4124.835006599702;3290.226796702773;3560.857565697343;3592.2815436912724;3821.2357528494413;4023.8591649292134;3895.53253609563;3975.8012099394914;4217.481706585627;4672.2057250267535;4713.935941637894;5771.682557459296;5805.651660900359;5806.448387403275;5809.9419005809405;5909.615874968199;1170.9180357374903;1322.259534660593;1324.562849308511;1339.6115126613367;1355.4480120262244;871.2550769092461;896.9282457403392;919.2232563483846;920.2132176988579;920.9355345125776;5473.67157970523;5474.835754927359;5502.532284755841;5522.508922590878;5569;5035.320231768737;5532.723363831792;5956.136360227742;6049.485793707496;6055.7274922628585;5023.874403139951;5249.3694891395935;5282.2340760589495;5319.893602127936;5456.427075157131;2415.1667674652217;2426.2599907028525;2553.9784086365603;2565.756253155947;2611.1460862787253;4532.388127602798;4983.50494851543;5021.974890125599;5050.873728156752;5082.440931497532;4065.7153999220363;4218.920188262586;4663.883402914954;5012.844476874906;5033.597312215014;4797.976010119857;4818.927716084261;4932;5042.546170844642;5080.390353157644;4467.977660111678;4474.776261186993;4908.6073114151495;4911.557959783637;4937.593060788045;4127.8968025799595;4176.832926682899;4784.593409447302;5286.709230992178;6021.277446706248;5711.314642242957;5890.852728681646;6290.49676025926;6292.937070629235;6346.936530634634;3318.303156337196;3985.501812273466;4008.398740188995;4011.91976160481;4024.1549274652652;4944.489521283987;5461.098918678374;5637.774489020393;5950.910736339045;6122.908156377569;5158.509941555546;5612;5637.887242255214;5827.504662103769;5859.736311865891;4792.832250871203;5083.2883396323805;5906.7341969612335;5910.744264129819;5990.891685038282;4576.656750743641;5114.442778610694;5342.252084708221;5706.9714651426475;5758.042265629706;4852.228936438245;5072.333453223117;5622.313306008099;5810.738516766671;5931.584789064724;4380.0582874682095;4986.850394488171;5112.514311140436;5775.191473193672;5790 15:03:12 INFO - PROCESS | 1663 | |5;yui.html;617.4504690825165;698.9405900498457;717.3794667612515;766.3983772738397;812.419120328965;15006.849931500681;15820.525384238463;15921.68156636868;16246.187690615452;16359.427420040316;14435.711285774305;14753.926230368834;14760.114393136419;14761.040532365416;14780.113193208388;686.7527690031585;843.0599881132555;872.1409411729442;873.9650413983433;875.011237301848;603.6658983646147;840.6343240690288;865.208334374047;874.8906386701663;877.7235170921172;914.6570036236411;917.0142097245488;918.0360621347592;918.9862152067724;920.3511524375299;907.1790030022839;910.535626830318;910.5583791860943;910.7677542226756;912.0332447605526;653.5980372071142;669.7086767256259;674.5345711459078;674.7368526274756;675.3347952267062;14969.476068337555;14998.100113993196;15011.099334039993;15037.323320450607;15064.548063558112;14344.282785860769;14490.710185796224;14510.637234069127;14524.927375363055;14836.3323650436;11583.536658533649;11625.631422880742;11713.004394626467;11787.587434439753;11880.881191188151;3194.88817891375;3786.110264087937;3850.711196660234;3879.844806207748;3994.560598334181;97541;98016.50991744996;98081.50959245158;99505;101110.49444752802;11151.553937842395;11200.43997800123;11289.096872250364;11386.658400248005;11391.316521008766;22746.976386062666;22795.772042279696;22817.087316507153;23100.65349019766;23216.53566928652;7942.126366099725;7983.281504664608;7994.960025199953;7999;8113.391495637851;4389.84635537761;4430.822767089345;4469.21788686985;4516.345129956138;4544.772761361919;3593.4789455528803;3694.0949467380665;3705.6850167735506;3709.666130048309;3733.178700685845;656.9605823650501;662.1722846441947;666.4102269491437;684.4319215051595;684.6029303004245;608.4402349838159;650.7012122652767;663.2754837422663;670.4267850987336;686.2588404523103;7499.713732382147;9511.857322140173;9648.469334186688;9672.177864881563;9812.215022798158;526.5182358142333;529.4724719185102;561.1526594841819;573.9741711622987;681.877262092828;3381.5773028371455;3728.9931718436414;3841.750286231386;4278.7004909656025;5128.948710512922;144729;149551;156171;157939;162760.37239627453;110733.44633276782;115055;118890;134778;137787.6221237775;72238.63880680563;84587;105039;105848;107450.46274768733;9119.361644684808;9953.303268771117;10003.949980250052;10023.198144148304;10085.596576136872;50283.99432011266;54237.72881135727;58138;58888.70555647194;59280.70359648174;85587.57206214179;88907.66638500558;90685.54657226671;91232;94422;11356.772864542498;12865.678358041125;13136.146150500186;13259.403326850123;13479;14571.927140364654;14642.341094650554;14710.264486775832;14826.036307639968;15046.247687615794;13409;13545.32273386307;13570.86429135696;13922.303884805517;14341.713165736419;13562.050656453954;13742.450301987808;13802.378892950042;13922.373493193034;14128.431275394241;13209.933950330187;13390.397432115384;13491.392887320291;13594.320283985564;13979.930100349433;10658.573657053632;10820.729481763019;11375.26060806045;11404.600838970597;11722.296662200295;10701.571937122428;11347.489362978851;11431.304555781444;11610.88389116098;11632 15:03:12 INFO - PROCESS | 1663 | __end_tp_report 15:03:12 INFO - PROCESS | 1663 | __start_cc_report 15:03:12 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,377 15:03:12 INFO - PROCESS | 1663 | __end_cc_report 15:03:12 INFO - PROCESS | 1663 | __startTimestamp1475618592768__endTimestamp 15:03:12 INFO - PROCESS | 1663 | 15:03:12 INFO - PROCESS | 1663 | ------- Summary: start ------- 15:03:12 INFO - PROCESS | 1663 | Number of tests: 6 15:03:12 INFO - PROCESS | 1663 | 15:03:12 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5675.49 Median:5989.76 stddev:683.32 (11.4%) stddev-sans-first:660.75 15:03:12 INFO - PROCESS | 1663 | Values: 3356.4 3361.1 3397.8 3397.8 3401.5 5247.8 5609.0 5653.0 5745.0 5755.7 5655.0 5732.5 5767.6 5774.8 5776.7 5128.9 5187.5 5209.6 5225.3 5240.8 5189.2 5266.8 5270.0 5292.5 5297.0 5104.7 5224.1 5250.7 5256.9 5350.7 5109.0 5151.6 5156.0 5197.4 5266.1 4308.9 4532.2 5128.0 5151.1 5155.8 4222.2 4244.2 4862.3 5712.9 5719.7 6071.3 6085.9 6144.4 6152.6 6157.8 5923.9 6204.3 6219.9 6243.9 6261.6 5819.2 5821.8 5829.0 5832.1 5864.9 6112.0 6126.8 6128.7 6219.2 6250.1 6065.5 6112.3 6118.0 6122.0 6145.6 6161.3 6172.5 6203.8 6213.3 6234.0 6028.2 6050.8 6102.8 6135.3 6136.2 6187.1 6232.4 6240.8 6248.0 6295.3 4900.7 4915.7 4923.1 4935.5 4937.1 3324.8 4372.6 4389.4 4442.2 4463.0 5809.5 5818.6 5834.4 5863.4 5921.7 6214.1 6234.4 6237.3 6258.7 6262.1 5650.2 5793.5 5837.5 5873.5 5891.5 5304.5 5322.7 5348.2 5359.9 5393.1 6237.3 6240.7 6242.2 6245.3 6247.2 6119.0 6207.2 6227.6 6235.7 6241.6 6127.2 6136.2 6158.4 6172.5 6251.2 6071.5 6135.3 6136.8 6140.8 6148.3 5045.4 6225.0 6253.8 6261.1 6262.6 5649.1 5792.7 6057.5 6085.2 6110.7 6129.6 6132.5 6142.0 6148.3 6148.9 4729.9 5460.1 5843.5 5991.1 5993.1 6079.3 6093.2 6133.6 6136.2 6140.8 5989.8 6029.6 6031.4 6041.5 6044.5 15:03:12 INFO - PROCESS | 1663 | 15:03:12 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:64518.78 Median:39099.50 stddev:138544.01 (354.3%) stddev-sans-first:138849.30 15:03:12 INFO - PROCESS | 1663 | Values: 506.0 522.6 528.2 554.0 562.0 29817.4 39743.6 39891.2 39904.6 39926.0 40491.8 40928.6 40948.0 41000.0 41010.0 8344.7 8791.3 9276.9 9727.7 9741.5 8488.6 8944.8 9531.5 9773.7 9821.3 8519.7 8624.0 9768.4 9778.7 9787.3 8542.7 9787.7 9795.8 9817.9 9821.1 9683.7 9776.2 9796.7 9803.3 9819.1 38732.0 38748.8 39049.2 39063.6 39115.0 3278.2 3418.3 3427.3 3465.1 3798.5 30477.7 30872.2 31032.5 31558.5 31637.8 3205.5 3237.0 3241.2 3285.8 3334.4 441987.8 445574.0 445994.0 447515.5 449082.0 56523.9 56910.4 56980.4 57103.4 57137.4 57819.0 58568.7 58648.7 58669.7 58811.7 15625.5 15763.6 15872.3 15882.2 15924.3 12271.5 12445.6 12481.5 12486.7 12502.4 12535.4 12947.0 13893.9 14936.0 15009.6 3208.2 6071.0 6184.0 6244.2 6271.7 753.9 926.9 995.0 1009.8 1051.0 25787.5 28314.2 28875.9 29236.0 30260.5 972.5 996.4 1016.5 1051.4 1054.5 13676.4 14782.8 15425.5 15513.3 15694.5 494370.5 609315.0 629119.0 636143.0 639803.6 55937.9 56009.7 56105.4 56287.0 56604.0 1150.7 1355.6 1382.3 1384.0 1385.5 28611.4 29223.9 29650.9 30149.8 30155.8 47390.0 47429.0 47801.3 47836.3 47871.5 439499.0 443039.0 449566.0 559291.0 560804.0 25626.9 25841.9 25844.7 26142.1 26184.3 45903.0 46656.8 46964.0 46964.5 46982.3 36634.8 38095.2 38164.8 38519.0 39084.0 31678.8 32401.8 35422.6 38069.6 38590.2 36117.3 36678.8 37160.9 37362.4 37424.4 27903.7 32510.8 33128.5 33754.8 33925.3 21396.5 22063.0 22331.2 23405.8 24618.8 15:03:12 INFO - PROCESS | 1663 | 15:03:12 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35405.42 Median:14694.14 stddev:97977.31 (666.8%) stddev-sans-first:98216.79 15:03:12 INFO - PROCESS | 1663 | Values: 341.4 372.9 373.8 376.1 396.5 17509.4 20824.6 21355.8 21733.6 21996.7 19684.0 20022.1 20131.4 20974.0 21469.2 5847.1 5852.5 6008.8 6069.6 6166.5 4211.4 4411.2 5936.1 6056.1 6081.1 5729.6 6422.0 6685.0 6785.3 6790.2 6552.5 6733.0 6752.9 6758.1 6771.8 5792.5 5828.9 5832.4 5852.7 5864.4 26132.9 26221.1 26235.2 26313.7 26512.8 1863.8 2370.9 2634.5 2875.5 3060.9 14274.0 15426.7 15619.8 15845.4 16652.6 1515.5 1549.8 1792.8 1879.7 1895.0 121816.6 128976.0 129517.0 130185.0 130573.3 10097.2 11034.7 11366.8 11581.5 11603.7 14434.9 14482.7 14505.9 14595.6 14622.1 8544.4 8619.9 8632.8 8694.7 8738.6 7090.5 8383.1 8507.7 8655.4 8664.8 3789.0 3825.0 3850.4 4033.0 4392.2 1581.3 1671.2 1909.3 1967.4 1988.2 829.4 884.4 899.3 924.1 932.8 20133.0 20865.4 21261.8 21423.0 21761.2 767.8 850.3 952.9 957.2 969.0 10085.9 10963.7 11400.5 11507.9 11525.8 562803.0 584162.0 585046.0 587335.0 592675.0 136307.0 137293.0 137990.6 142175.0 142289.3 986.0 990.3 1014.2 1014.8 1015.7 19385.8 19566.7 19586.6 19633.9 19640.6 51957.7 53343.0 57840.0 57990.6 58933.0 65273.0 82376.2 82678.2 83556.6 84106.0 7190.1 7233.3 7380.1 7506.1 7558.6 10579.3 11474.3 12454.3 12654.9 12781.5 9466.8 10917.9 11006.4 11270.2 11551.0 10074.0 10369.8 10713.4 11211.8 11363.3 6170.0 8580.5 11484.7 11507.1 11708.8 6974.5 7287.3 7354.0 7365.3 7522.3 7369.8 9233.4 11153.8 11309.6 11379.4 15:03:12 INFO - PROCESS | 1663 | 15:03:12 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5683.02 Median:4633.74 stddev:3256.21 (70.3%) stddev-sans-first:3249.91 15:03:12 INFO - PROCESS | 1663 | Values: 1464.5 1551.6 1644.4 1733.3 1864.5 8221.8 8410.5 8664.6 9266.8 9296.9 7577.9 8707.2 9014.5 9018.2 9176.3 2279.1 2294.4 2302.8 2318.4 2318.9 2345.7 2373.0 2390.6 2391.2 2398.7 2367.8 2379.0 2382.5 2411.9 2413.3 2364.9 2379.8 2386.8 2392.4 2394.0 2358.7 2372.8 2376.0 2378.9 2382.7 8981.9 9107.5 9124.0 9157.6 9189.3 5316.4 5482.6 5488.8 5492.2 5502.6 3529.2 3659.9 3660.0 3725.3 3725.8 1082.8 1085.3 1095.0 1097.6 1101.6 10097.8 11680.6 11832.3 11906.1 11960.2 4363.8 4439.5 4626.2 4635.1 4638.6 9163.5 9277.2 9310.6 9339.7 9353.9 4632.4 5167.2 5267.6 5269.6 5296.7 4446.4 4612.0 4797.4 4905.7 4916.0 3688.3 3695.6 3786.8 3800.9 3824.4 1157.6 1167.0 1171.7 1173.5 1178.4 878.1 887.4 898.5 910.0 911.2 5668.3 5681.9 5928.3 6052.8 6174.9 385.7 409.7 411.7 431.1 435.3 3782.2 3904.7 3938.6 3998.9 4001.8 10708.9 10925.8 11091.3 11118.1 11122.1 10116.8 10981.9 10986.9 11063.1 11078.3 7926.5 8324.0 8393.4 8394.6 8407.2 4790.9 4885.8 4928.0 5889.9 6255.7 8687.9 9801.4 10167.0 10319.3 10329.6 10550.6 10557.9 10567.5 10568.8 10585.8 6314.0 7309.8 7453.3 7462.7 7609.4 8349.7 8443.4 8469.2 8501.1 8581.9 6212.0 7642.7 7643.5 7670.3 7693.0 7285.1 7444.7 7477.8 7500.4 7518.7 6974.2 6982.8 7073.4 7074.4 7078.5 4062.3 4215.4 4949.6 5018.6 5027.2 4664.8 4923.2 4977.2 5057.7 5113.1 15:03:12 INFO - PROCESS | 1663 | 15:03:12 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4466.78 Median:4913.47 stddev:1393.93 (28.4%) stddev-sans-first:1362.23 15:03:12 INFO - PROCESS | 1663 | Values: 295.9 300.6 306.2 312.1 312.2 5286.3 5505.6 5515.7 5569.9 5606.3 5284.4 5418.2 5479.5 5490.5 5492.5 4145.3 4150.1 4196.7 4203.5 4215.4 4023.7 4160.4 4164.9 4193.3 4198.8 3193.9 3447.6 3680.1 4135.8 4136.5 3065.3 3996.3 4092.7 4148.2 4165.4 3583.1 3622.6 3625.9 3631.8 3637.8 4109.7 4804.8 4915.4 5221.8 5275.4 4549.9 4644.9 4746.3 4763.8 4778.7 5003.3 5678.9 5751.6 5791.2 5826.2 3577.8 3633.9 3788.9 3910.9 3942.4 4763.7 4843.6 5299.2 5490.9 6150.8 3425.6 4027.3 4071.7 4085.6 4124.8 3290.2 3560.9 3592.3 3821.2 4023.9 3895.5 3975.8 4217.5 4672.2 4713.9 5771.7 5805.7 5806.4 5809.9 5909.6 1170.9 1322.3 1324.6 1339.6 1355.4 871.3 896.9 919.2 920.2 920.9 5473.7 5474.8 5502.5 5522.5 5569.0 5035.3 5532.7 5956.1 6049.5 6055.7 5023.9 5249.4 5282.2 5319.9 5456.4 2415.2 2426.3 2554.0 2565.8 2611.1 4532.4 4983.5 5022.0 5050.9 5082.4 4065.7 4218.9 4663.9 5012.8 5033.6 4798.0 4818.9 4932.0 5042.5 5080.4 4468.0 4474.8 4908.6 4911.6 4937.6 4127.9 4176.8 4784.6 5286.7 6021.3 5711.3 5890.9 6290.5 6292.9 6346.9 3318.3 3985.5 4008.4 4011.9 4024.2 4944.5 5461.1 5637.8 5950.9 6122.9 5158.5 5612.0 5637.9 5827.5 5859.7 4792.8 5083.3 5906.7 5910.7 5990.9 4576.7 5114.4 5342.3 5707.0 5758.0 4852.2 5072.3 5622.3 5810.7 5931.6 4380.1 4986.9 5112.5 5775.2 5790.0 15:03:12 INFO - PROCESS | 1663 | 15:03:12 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:24028.02 Median:3699.89 stddev:38083.63 (1029.3%) stddev-sans-first:38149.90 15:03:12 INFO - PROCESS | 1663 | Values: 617.5 698.9 717.4 766.4 812.4 15006.8 15820.5 15921.7 16246.2 16359.4 14435.7 14753.9 14760.1 14761.0 14780.1 686.8 843.1 872.1 874.0 875.0 603.7 840.6 865.2 874.9 877.7 914.7 917.0 918.0 919.0 920.4 907.2 910.5 910.6 910.8 912.0 653.6 669.7 674.5 674.7 675.3 14969.5 14998.1 15011.1 15037.3 15064.5 14344.3 14490.7 14510.6 14524.9 14836.3 11583.5 11625.6 11713.0 11787.6 11880.9 3194.9 3786.1 3850.7 3879.8 3994.6 97541.0 98016.5 98081.5 99505.0 101110.5 11151.6 11200.4 11289.1 11386.7 11391.3 22747.0 22795.8 22817.1 23100.7 23216.5 7942.1 7983.3 7995.0 7999.0 8113.4 4389.8 4430.8 4469.2 4516.3 4544.8 3593.5 3694.1 3705.7 3709.7 3733.2 657.0 662.2 666.4 684.4 684.6 608.4 650.7 663.3 670.4 686.3 7499.7 9511.9 9648.5 9672.2 9812.2 526.5 529.5 561.2 574.0 681.9 3381.6 3729.0 3841.8 4278.7 5128.9 144729.0 149551.0 156171.0 157939.0 162760.4 110733.4 115055.0 118890.0 134778.0 137787.6 72238.6 84587.0 105039.0 105848.0 107450.5 9119.4 9953.3 10003.9 10023.2 10085.6 50284.0 54237.7 58138.0 58888.7 59280.7 85587.6 88907.7 90685.5 91232.0 94422.0 11356.8 12865.7 13136.1 13259.4 13479.0 14571.9 14642.3 14710.3 14826.0 15046.2 13409.0 13545.3 13570.9 13922.3 14341.7 13562.1 13742.5 13802.4 13922.4 14128.4 13209.9 13390.4 13491.4 13594.3 13979.9 10658.6 10820.7 11375.3 11404.6 11722.3 10701.6 11347.5 11431.3 11610.9 11632.0 15:03:12 INFO - PROCESS | 1663 | -------- Summary: end -------- 15:03:12 INFO - PROCESS | 1663 | 15:03:13 INFO - TEST-INFO | 1663: exit 0 15:03:13 INFO - TEST-OK | dromaeo_css | took 1114888ms 15:03:13 INFO - TEST-START | kraken 15:03:13 INFO - operating with platform_type : mac_ 15:03:13 INFO - Initialising browser for kraken test... 15:03:13 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmp7PA7TM/profile http://localhost:49279/getInfo.html) 15:03:16 INFO - PROCESS | 1671 | 2016-10-04 15:03:16.056 plugin-container[1672:10109] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d27, name = 'com.apple.tsm.portname' 15:03:16 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:03:16 INFO - PROCESS | 1671 | 2016-10-04 15:03:16.060 plugin-container[1672:10109] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 15:03:16 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:03:16 INFO - PROCESS | 1671 | 2016-10-04 15:03:16.061 plugin-container[1672:10109] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:03:16 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 15:03:16 INFO - PROCESS | 1671 | colorDepth:24 15:03:16 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 15:03:16 INFO - PROCESS | 1671 | __metrics 15:03:16 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 15:03:16 INFO - TEST-INFO | 1671: exit 0 15:03:16 INFO - Browser initialized. 15:03:16 INFO - Running cycle 1/1 for kraken test... 15:03:16 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmp7PA7TM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:03:19 INFO - PROCESS | 1673 | 2016-10-04 15:03:19.341 plugin-container[1674:10229] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.tsm.portname' 15:03:19 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:03:19 INFO - PROCESS | 1673 | 2016-10-04 15:03:19.345 plugin-container[1674:10229] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 15:03:19 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:03:19 INFO - PROCESS | 1673 | 2016-10-04 15:03:19.345 plugin-container[1674:10229] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:03:28 INFO - PROCESS | 1673 | RSS: Main: 240271360 15:03:28 INFO - PROCESS | 1673 | 15:03:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 15:03:32 INFO - PROCESS | 1673 | RSS: Main: 253632512 15:03:32 INFO - PROCESS | 1673 | 15:03:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 15:03:35 INFO - PROCESS | 1673 | RSS: Main: 261242880 15:03:35 INFO - PROCESS | 1673 | 15:03:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 15:03:40 INFO - PROCESS | 1673 | RSS: Main: 261869568 15:03:40 INFO - PROCESS | 1673 | 15:03:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 15:03:42 INFO - PROCESS | 1673 | RSS: Main: 264413184 15:03:42 INFO - PROCESS | 1673 | 15:03:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:03:45 INFO - PROCESS | 1673 | RSS: Main: 264609792 15:03:45 INFO - PROCESS | 1673 | 15:03:48 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 15:03:48 INFO - PROCESS | 1673 | RSS: Main: 265658368 15:03:48 INFO - PROCESS | 1673 | 15:03:51 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 15:03:52 INFO - PROCESS | 1673 | RSS: Main: 265736192 15:03:52 INFO - PROCESS | 1673 | 15:03:55 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 15:03:56 INFO - PROCESS | 1673 | RSS: Main: 265977856 15:03:56 INFO - PROCESS | 1673 | 15:03:57 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:03:58 INFO - PROCESS | 1673 | RSS: Main: 265728000 15:03:58 INFO - PROCESS | 1673 | 15:04:00 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:04:00 INFO - PROCESS | 1673 | RSS: Main: 265781248 15:04:00 INFO - PROCESS | 1673 | 15:04:03 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:04:03 INFO - PROCESS | 1673 | RSS: Main: 265805824 15:04:03 INFO - PROCESS | 1673 | 15:04:06 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:04:07 INFO - PROCESS | 1673 | RSS: Main: 266186752 15:04:07 INFO - PROCESS | 1673 | 15:04:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:04:11 INFO - PROCESS | 1673 | RSS: Main: 266182656 15:04:11 INFO - PROCESS | 1673 | 15:04:12 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 15:04:13 INFO - PROCESS | 1673 | RSS: Main: 267538432 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | __start_tp_report 15:04:13 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 15:04:13 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 15:04:13 INFO - PROCESS | 1673 | |i|pagename|runs| 15:04:13 INFO - PROCESS | 1673 | |0;ai-astar;117;118;118;117;119;118;118;118;119;117 15:04:13 INFO - PROCESS | 1673 | |1;audio-beat-detection;178;146;106;178;113;139;109;133;162;106 15:04:13 INFO - PROCESS | 1673 | |2;audio-dft;198;194;210;286;182;193;268;263;197;196 15:04:13 INFO - PROCESS | 1673 | |3;audio-fft;73;58;59;82;59;61;51;78;89;80 15:04:13 INFO - PROCESS | 1673 | |4;audio-oscillator;86;100;116;100;68;69;88;72;69;88 15:04:13 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;93;77;136;85;102;87;117;84;134;75 15:04:13 INFO - PROCESS | 1673 | |6;imaging-darkroom;150;96;98;96;109;97;97;97;98;95 15:04:13 INFO - PROCESS | 1673 | |7;imaging-desaturate;82;81;77;132;144;132;92;80;145;148 15:04:13 INFO - PROCESS | 1673 | |8;json-parse-financial;57;55;55;55;58;58;63;89;47;51 15:04:13 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;68;66;74;74;73;67;69;70;69;72 15:04:13 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;90;86;80;84;109;108;107;89;90;88 15:04:13 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;162;167;151;146;142;144;150;147;184;144 15:04:13 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;176;178;174;173;176;175;175;177;176;176 15:04:13 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;66;83;93;93;76;73;98;91;94;89 15:04:13 INFO - PROCESS | 1673 | __end_tp_report 15:04:13 INFO - PROCESS | 1673 | __start_cc_report 15:04:13 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,935 15:04:13 INFO - PROCESS | 1673 | __end_cc_report 15:04:13 INFO - PROCESS | 1673 | __startTimestamp1475618653175__endTimestamp 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | ------- Summary: start ------- 15:04:13 INFO - PROCESS | 1673 | Number of tests: 14 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 15:04:13 INFO - PROCESS | 1673 | Values: 117.0 118.0 118.0 117.0 119.0 118.0 118.0 118.0 119.0 117.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:142.50 stddev:28.62 (20.1%) stddev-sans-first:26.23 15:04:13 INFO - PROCESS | 1673 | Values: 178.0 146.0 106.0 178.0 113.0 139.0 109.0 133.0 162.0 106.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:218.70 Median:204.00 stddev:38.05 (18.7%) stddev-sans-first:39.61 15:04:13 INFO - PROCESS | 1673 | Values: 198.0 194.0 210.0 286.0 182.0 193.0 268.0 263.0 197.0 196.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:69.00 Median:75.50 stddev:12.89 (17.1%) stddev-sans-first:13.59 15:04:13 INFO - PROCESS | 1673 | Values: 73.0 58.0 59.0 82.0 59.0 61.0 51.0 78.0 89.0 80.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:85.60 Median:70.50 stddev:16.32 (23.1%) stddev-sans-first:17.31 15:04:13 INFO - PROCESS | 1673 | Values: 86.0 100.0 116.0 100.0 68.0 69.0 88.0 72.0 69.0 88.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:99.00 Median:80.50 stddev:22.58 (28.0%) stddev-sans-first:23.84 15:04:13 INFO - PROCESS | 1673 | Values: 93.0 77.0 136.0 85.0 102.0 87.0 117.0 84.0 134.0 75.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:103.30 Median:97.00 stddev:16.88 (17.4%) stddev-sans-first:4.20 15:04:13 INFO - PROCESS | 1673 | Values: 150.0 96.0 98.0 96.0 109.0 97.0 97.0 97.0 98.0 95.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:111.30 Median:78.50 stddev:31.12 (39.6%) stddev-sans-first:31.15 15:04:13 INFO - PROCESS | 1673 | Values: 82.0 81.0 77.0 132.0 144.0 132.0 92.0 80.0 145.0 148.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:57.50 stddev:11.44 (19.9%) stddev-sans-first:12.11 15:04:13 INFO - PROCESS | 1673 | Values: 57.0 55.0 55.0 55.0 58.0 58.0 63.0 89.0 47.0 51.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:71.00 stddev:2.90 (4.1%) stddev-sans-first:2.96 15:04:13 INFO - PROCESS | 1673 | Values: 68.0 66.0 74.0 74.0 73.0 67.0 69.0 70.0 69.0 72.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:87.00 stddev:10.72 (12.3%) stddev-sans-first:11.31 15:04:13 INFO - PROCESS | 1673 | Values: 90.0 86.0 80.0 84.0 109.0 108.0 107.0 89.0 90.0 88.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:150.50 stddev:13.39 (8.9%) stddev-sans-first:13.86 15:04:13 INFO - PROCESS | 1673 | Values: 162.0 167.0 151.0 146.0 142.0 144.0 150.0 147.0 184.0 144.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:176.00 stddev:1.43 (0.8%) stddev-sans-first:1.51 15:04:13 INFO - PROCESS | 1673 | Values: 176.0 178.0 174.0 173.0 176.0 175.0 175.0 177.0 176.0 176.0 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.60 Median:92.00 stddev:10.63 (11.6%) stddev-sans-first:8.58 15:04:13 INFO - PROCESS | 1673 | Values: 66.0 83.0 93.0 93.0 76.0 73.0 98.0 91.0 94.0 89.0 15:04:13 INFO - PROCESS | 1673 | -------- Summary: end -------- 15:04:13 INFO - PROCESS | 1673 | 15:04:13 INFO - TEST-INFO | 1673: exit 0 15:04:14 INFO - TEST-OK | kraken | took 60604ms 15:04:14 INFO - SUITE-END | took 1175s 15:04:14 INFO - Completed test suite (00:19:35) 15:04:14 INFO - javascript benchmark 15:04:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7238.628470577269, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3356.4126277901364, 3361.0925050236438, 3397.7621566490325, 3397.7791443556175, 3401.4557670772665, 5247.763850626721, 5608.971955140219, 5653.0, 5745.023346031175, 5755.712214389285, 5655.0, 5732.5127364173995, 5767.596268261213, 5774.797882074128, 5776.682282474462, 5128.948710512894, 5187.48125187482, 5209.557187639036, 5225.294585230983, 5240.816571420001, 5189.221616757479, 5266.81566145185, 5270.0, 5292.523672869441, 5296.973515132419, 5104.668196567211, 5224.059669259532, 5250.7112108834, 5256.947430525704, 5350.652207606513, 5108.978204359143, 5151.5878729701535, 5156.04613146569, 5197.350331208599, 5266.052110620087, 4308.879691280258, 4532.161550113239, 5128.0, 5151.098557752416, 5155.845324640267, 4222.155568886235, 4244.236037513247, 4862.343583616202, 5712.914306285367, 5719.7140142992685, 6071.332153463116, 6085.878282434326, 6144.416280453394, 6152.600080994721, 6157.815265541996, 5923.881522369528, 6204.317525072239, 6219.937800621981, 6243.906341404882, 6261.561690681654, 5819.214406055128, 5821.825345239649, 5828.950788857961, 5832.12518122285, 5864.853378665525, 6111.95640283616, 6126.792505495304, 6128.717018009172, 6219.1604133442315, 6250.062490626351, 6065.4541091302, 6112.26032301701, 6118.0, 6121.96939015311, 6145.586515101462, 6161.3259229064115, 6172.506199504029, 6203.7828675996125, 6213.254409470893, 6234.0, 6028.186194863725, 6050.818475445743, 6102.822530595962, 6135.325114237519, 6136.21274067861, 6187.133801267826, 6232.439080482778, 6240.812775616739, 6247.968760156261, 6295.3389894060465, 4900.681455705368, 4915.705057696549, 4923.138450771101, 4935.531124543163, 4937.1113199624415, 3324.750643701732, 4372.584604462571, 4389.363542286351, 4442.178197033559, 4462.977685111554, 5809.535237181015, 5818.6217895836635, 5834.38738932406, 5863.442972917566, 5921.73352199152, 6214.130021796952, 6234.407731265523, 6237.313895471494, 6258.74965001404, 6262.12330273762, 5650.180723795109, 5793.536517078624, 5837.532997360201, 5873.500752436091, 5891.49922256613, 5304.469553044664, 5322.654027488201, 5348.171033489815, 5359.919601205985, 5393.110136827379, 6237.313895471585, 6240.656763878031, 6242.219722534684, 6245.250569931637, 6247.219097612799, 6119.015143218386, 6207.16203312547, 6227.595206311576, 6235.657038862906, 6241.625502469685, 6127.1589861177945, 6136.151476879544, 6158.445739883432, 6172.475339596005, 6251.187345645037, 6071.51427885777, 6135.263768347827, 6136.846578835565, 6140.785072522441, 6148.262208535004, 5045.394552653705, 6225.0, 6253.812385628438, 6261.123442717932, 6262.561620686508, 5649.096144616841, 5792.652440853562, 6057.515398768176, 6085.208922840003, 6110.7106460192745, 6129.572745043327, 6132.478739307209, 6141.986572215713, 6148.292946311231, 6148.877022459436, 4729.929051064168, 5460.126379779216, 5843.532517398683, 5991.131285963598, 5993.130996005642, 6079.3312735598165, 6093.238345206849, 6133.601315914451, 6136.243373036893, 6140.84169297792, 5989.760409583568, 6029.577929545065, 6031.36670649593, 6041.546883983631, 6044.486218671286], "value": 5631.562794310347, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.9822906198283, 522.644601670864, 528.2261486921659, 553.9806106786264, 561.9912257497792, 29817.403651926976, 39743.60256397435, 39891.20217595647, 39904.60095399045, 39926.0, 40491.79754101225, 40928.59071409285, 40948.0, 41000.02999490086, 41010.0, 8344.749657510254, 8791.252743516809, 9276.907230927673, 9727.659531916384, 9741.512924353789, 8488.618012189467, 8944.83717116774, 9531.523423828816, 9773.657921972732, 9821.263405244636, 8519.74440766775, 8624.0, 9768.413895166277, 9778.657746978857, 9787.265955053399, 8542.658293668246, 9787.706368808947, 9795.804083918281, 9817.901820981806, 9821.066998635119, 9683.709488715349, 9776.16902563283, 9796.706098817047, 9803.31376803624, 9819.116279534876, 38732.031699207466, 38748.80625596882, 39049.21901561981, 39063.60936390628, 39115.0, 3278.1506338553318, 3418.3334249821046, 3427.2974040321924, 3465.1337165708574, 3798.487204227449, 30477.695223047707, 30872.228194295098, 31032.53451198234, 31558.526622100686, 31637.84181079103, 3205.5031470122167, 3236.951445728316, 3241.222106694376, 3285.78642388244, 3334.366470370646, 441987.79006105085, 445574.0, 445994.0, 447515.5248447539, 449082.0, 56523.86952260932, 56910.430895691345, 56980.43019569834, 57103.42896571064, 57137.42862571404, 57819.0, 58568.70715646395, 58648.706756465945, 58669.70665146647, 58811.70594147002, 15625.531234062997, 15763.605909852346, 15872.285747141406, 15882.205889705469, 15924.283407246701, 12271.509139634314, 12445.62663120108, 12481.500739970299, 12486.687832804253, 12502.3748812559, 12535.43590538428, 12947.0, 13893.86106138946, 14936.0, 15009.624759381102, 3208.246062175387, 6070.998285282879, 6183.96908015457, 6244.157973397859, 6271.717772700239, 753.9283768042027, 926.9304802139867, 994.9502524873727, 1009.7677534167183, 1050.9579616815242, 25787.484250315265, 28314.168583141935, 28875.855620721763, 29235.976740814396, 30260.54609180864, 972.4748635736764, 996.4270544436978, 1016.537475448669, 1051.358671210561, 1054.5254635414094, 13676.384562694702, 14782.778258326134, 15425.460108896135, 15513.336060748203, 15694.450694225647, 494370.5066544028, 609315.0, 629119.0, 636143.0, 639803.6019639744, 55937.881242374926, 56009.71995139998, 56105.43894561084, 56287.0, 56604.0, 1150.6950658075616, 1355.613650109714, 1382.3433868911984, 1384.0311781752612, 1385.47352006239, 28611.427771444873, 29223.85388073046, 29650.851745741133, 30149.849250754483, 30155.849220754633, 47390.0, 47429.0, 47801.28298075462, 47836.28245576389, 47871.5212847881, 439499.0, 443039.0, 449566.0, 559291.0, 560804.0, 25626.871865641297, 25841.870790645928, 25844.741552584233, 26142.085027023964, 26184.34539136537, 45903.0, 46656.7667161662, 46964.0, 46964.53035469738, 46982.29526557036, 36634.80191188537, 38095.23809523849, 38164.80917595505, 38519.0370240735, 39084.0, 31678.841605791822, 32401.837990809894, 35422.64577354193, 38069.61930380772, 38590.228195435375, 36117.27765444729, 36678.8166059168, 37160.88517344484, 37362.43956340711, 37424.43863341997, 27903.720962790114, 32510.83744581262, 33128.50307245441, 33754.8312258447, 33925.3214935695, 21396.50224484271, 22063.0, 22331.218407355664, 23405.79746367248, 24618.753812462364], "value": 19001.35195088181, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.4229951382164, 372.9036632301033, 373.76452834714127, 376.1461482434873, 396.54397442940615, 17509.387171449, 20824.583508329823, 21355.786442135573, 21733.565328693436, 21996.670049949265, 19684.0, 20022.099005544747, 20131.396058118244, 20974.0, 21469.248576299833, 5847.122931560279, 5852.502537284326, 6008.849778755544, 6069.57512974092, 6166.537509686791, 4211.368294755781, 4411.16187924295, 5936.079907614305, 6056.091586262052, 6081.118237855509, 5729.598928075036, 6422.0, 6685.0, 6785.287544807798, 6790.185177778649, 6552.508561857856, 6733.0237115617965, 6752.932470675329, 6758.12144421227, 6771.762988295411, 5792.536597072266, 5828.854278643025, 5832.366937257575, 5852.67810270435, 5864.354920958691, 26132.8693356532, 26221.082262120926, 26235.21294361172, 26313.736862631322, 26512.80692368848, 1863.8043005484365, 2370.881455927214, 2634.4599357131933, 2875.4680384129, 3060.8521804323377, 14274.0, 15426.691466170614, 15619.765703514457, 15845.366185352572, 16652.58368540784, 1515.4923100761148, 1549.821770496396, 1792.82071792821, 1879.736836842843, 1895.0, 121816.56366872702, 128976.0, 129517.0, 130184.99999999905, 130573.34713326467, 10097.192224622013, 11034.675838899384, 11366.772664546663, 11581.536738530365, 11603.709907252218, 14434.927825360806, 14482.710345793024, 14505.927470362793, 14595.635109122144, 14622.122672639463, 8544.40189186751, 8619.91380086191, 8632.827343453097, 8694.740206556324, 8738.563071846509, 7090.539114957512, 8383.119772423808, 8507.659693612186, 8655.394122411371, 8664.78338041554, 3788.981055094707, 3824.9808750956067, 3850.403187505941, 4032.9596704032583, 4392.209402307615, 1581.2805173645963, 1671.2312336325426, 1909.3221906223368, 1967.4392798052486, 1988.2345297060735, 829.3903980574273, 884.38093334666, 899.325505870597, 924.0943875002536, 932.8320902237663, 20133.0, 20865.37403877886, 21261.78738212629, 21423.0, 21761.238356657443, 767.7850201943464, 850.336737344872, 952.9190018848337, 957.2437774158476, 968.9951550242204, 10085.949570252102, 10963.671089867317, 11400.48697808584, 11507.88492115085, 11525.810096081717, 562803.0, 584162.0, 585046.0, 587335.0, 592675.0, 136307.0, 137293.0, 137990.62009379777, 142175.0, 142289.28855355657, 985.975350616226, 990.321629683669, 1014.1734486393566, 1014.7818219082933, 1015.7105225010837, 19385.806141938963, 19566.72816266938, 19586.60826783485, 19633.920134392745, 19640.607187856447, 51957.740211298704, 53343.0, 57840.0, 57990.55023624274, 58933.0, 65273.0, 82376.17623823925, 82678.17321826705, 83556.58221708852, 84106.0, 7190.137183538009, 7233.348998590152, 7380.114386273682, 7506.061742282215, 7558.58427786477, 10579.31234469757, 11474.311541307548, 12454.25274483534, 12654.873451265737, 12781.48874045065, 9466.810663786548, 10917.945410272898, 11006.394648294421, 11270.211085223955, 11551.0, 10074.0, 10369.792604148026, 10713.35719856811, 11211.775764484502, 11363.261388009752, 6170.012797952306, 8580.485170889766, 11484.712882178012, 11507.1232191952, 11708.824367634663, 6974.476914231352, 7287.27127287267, 7354.043974283523, 7365.300296471826, 7522.285382888617, 7369.8157546061775, 9233.399829011092, 11153.832692509457, 11309.604163854226, 11379.374134422686], "value": 9623.07490688962, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.4654701034121, 1551.604340893072, 1644.4326707285989, 1733.272025749185, 1864.5245462407083, 8221.753347399572, 8410.495370277788, 8664.566771661415, 9266.814663706722, 9296.90703092969, 7577.924220757791, 8707.216350528452, 9014.504202268872, 9018.188363047324, 9176.265898728103, 2279.133929106937, 2294.4149241943283, 2302.792748652621, 2318.3856278086237, 2318.8724620145886, 2345.7067866516686, 2373.027058905849, 2390.6175011998084, 2391.1630929174826, 2398.6881705378364, 2367.822413318999, 2379.0245999140357, 2382.475855311837, 2411.9035238590436, 2413.2518919135036, 2364.929052128439, 2379.821513386503, 2386.8209884258576, 2392.4138586046442, 2394.042383046778, 2358.6697862299293, 2372.7864492195613, 2375.9524809503887, 2378.857268563874, 2382.702162229721, 8981.910180898172, 9107.5446227689, 9124.0, 9157.587908544132, 9189.264858811279, 5316.38861530925, 5482.616216864821, 5488.780448782044, 5492.176173573956, 5502.58730595203, 3529.2235708144167, 3659.9268014639824, 3659.963400365989, 3725.329440700673, 3725.776453412804, 1082.76720505091, 1085.2891356161726, 1094.9781004379947, 1097.6487523992325, 1101.5703875488566, 10097.798044039151, 11680.591179308683, 11832.290062596187, 11906.1070419718, 11960.222585532, 4363.80362883671, 4439.467263928284, 4626.21354369758, 4635.119327327864, 4638.628909687217, 9163.496007719506, 9277.16505514507, 9310.581023853943, 9339.719808405758, 9353.859692104625, 4632.351470794091, 5167.173252279617, 5267.552258058031, 5269.631125821233, 5296.655717378435, 4446.3552784846015, 4611.976940115278, 4797.376341075638, 4905.6811307265625, 4916.041371932439, 3688.2623475305045, 3695.593484716679, 3786.772793632391, 3800.8859734208017, 3824.4072168813877, 1157.583270022791, 1166.9632118326506, 1171.6777886081395, 1173.5129921082826, 1178.4166837415362, 878.1438097854668, 887.4409122252939, 898.4878619187001, 910.0399078971616, 911.2436677557612, 5668.319801623831, 5681.914771278434, 5928.347881733006, 6052.788152414732, 6174.938250617436, 385.65291237885566, 409.67635567901027, 411.6994593946376, 431.07534338843004, 435.31655301177483, 3782.1868298315994, 3904.7071469639322, 3938.6455219029854, 3998.900027499336, 4001.8399264029695, 10708.875568065398, 10925.836112458319, 11091.33451992883, 11118.054965328038, 11122.054625356774, 10116.848247276297, 10981.890181098086, 10986.890131098588, 11063.059639930536, 11078.279911805706, 7926.48477848938, 8323.95838020806, 8393.412461127784, 8394.580270986426, 8407.201315874981, 4790.880227994328, 4885.755712214304, 4927.9507204927495, 5889.852753681193, 6255.749770009149, 8687.913120868963, 9801.362911410735, 10167.034131757471, 10319.329243599143, 10329.638462653771, 10550.57336812522, 10557.894421055691, 10567.471626418803, 10568.84146737815, 10585.788284234119, 6314.0, 7309.817254568678, 7453.291937265951, 7462.701491940262, 7609.353204977418, 8349.666013359398, 8443.366747494085, 8469.195426434479, 8501.064882862756, 8581.871271931052, 6211.9689401552705, 7642.7325043623205, 7643.503172293783, 7670.27132422419, 7693.038370203724, 7285.125784905846, 7444.702211911463, 7477.775666730006, 7500.399968002437, 7518.661660225193, 6974.232834388112, 6982.825429364307, 7073.363397294062, 7074.398676112588, 7078.4691148163065, 4062.3297155968935, 4215.430916826189, 4949.554540091409, 5018.623603229699, 5027.170516864677, 4664.763837583111, 4923.163062279349, 4977.228529577921, 5057.721825299644, 5113.053306827809], "value": 4466.014248806427, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.8668599130392, 300.5686839385482, 306.15195907336675, 312.11359738343117, 312.1680720878858, 5286.31277933869, 5505.614606977513, 5515.669059856406, 5569.8886022279585, 5606.271184745982, 5284.39229488608, 5418.214358917954, 5479.506844384005, 5490.450954904508, 5492.47821456962, 4145.274576949029, 4150.149219410014, 4196.685248606352, 4203.5376108628025, 4215.40984262202, 4023.6781057515473, 4160.4383408239955, 4164.854230101947, 4193.287141185991, 4198.8320467181275, 3193.856276467553, 3447.5690538682666, 3680.1351682354625, 4135.77253251071, 4136.462259906208, 3065.264336559232, 3996.320625493673, 4092.6930480213805, 4148.191102734968, 4165.354370072643, 3583.104223944014, 3622.6377362263825, 3625.873094441682, 3631.8365673544754, 3637.8181090945345, 4109.691773117028, 4804.783784729696, 4915.3855768029, 5221.843344699665, 5275.360001598884, 4549.909001819979, 4644.86065418038, 4746.288056791474, 4763.785629646674, 4778.665493415462, 5003.322557919926, 5678.858028549319, 5751.626144300607, 5791.21818554494, 5826.242588463472, 3577.8336172487275, 3633.9273214535824, 3788.90527736806, 3910.921781564381, 3942.3889297158985, 4763.737994410306, 4843.636727245435, 5299.178627312773, 5490.890182196414, 6150.815475535741, 3425.5889293284467, 4027.275090483741, 4071.714979951434, 4085.550589435219, 4124.835006599702, 3290.226796702773, 3560.857565697343, 3592.2815436912724, 3821.2357528494413, 4023.8591649292134, 3895.53253609563, 3975.8012099394914, 4217.481706585627, 4672.2057250267535, 4713.935941637894, 5771.682557459296, 5805.651660900359, 5806.448387403275, 5809.9419005809405, 5909.615874968199, 1170.9180357374903, 1322.259534660593, 1324.562849308511, 1339.6115126613367, 1355.4480120262244, 871.2550769092461, 896.9282457403392, 919.2232563483846, 920.2132176988579, 920.9355345125776, 5473.67157970523, 5474.835754927359, 5502.532284755841, 5522.508922590878, 5569.0, 5035.320231768737, 5532.723363831792, 5956.136360227742, 6049.485793707496, 6055.7274922628585, 5023.874403139951, 5249.3694891395935, 5282.2340760589495, 5319.893602127936, 5456.427075157131, 2415.1667674652217, 2426.2599907028525, 2553.9784086365603, 2565.756253155947, 2611.1460862787253, 4532.388127602798, 4983.50494851543, 5021.974890125599, 5050.873728156752, 5082.440931497532, 4065.7153999220363, 4218.920188262586, 4663.883402914954, 5012.844476874906, 5033.597312215014, 4797.976010119857, 4818.927716084261, 4932.0, 5042.546170844642, 5080.390353157644, 4467.977660111678, 4474.776261186993, 4908.6073114151495, 4911.557959783637, 4937.593060788045, 4127.8968025799595, 4176.832926682899, 4784.593409447302, 5286.709230992178, 6021.277446706248, 5711.314642242957, 5890.852728681646, 6290.49676025926, 6292.937070629235, 6346.936530634634, 3318.303156337196, 3985.501812273466, 4008.398740188995, 4011.91976160481, 4024.1549274652652, 4944.489521283987, 5461.098918678374, 5637.774489020393, 5950.910736339045, 6122.908156377569, 5158.509941555546, 5612.0, 5637.887242255214, 5827.504662103769, 5859.736311865891, 4792.832250871203, 5083.2883396323805, 5906.7341969612335, 5910.744264129819, 5990.891685038282, 4576.656750743641, 5114.442778610694, 5342.252084708221, 5706.9714651426475, 5758.042265629706, 4852.228936438245, 5072.333453223117, 5622.313306008099, 5810.738516766671, 5931.584789064724, 4380.0582874682095, 4986.850394488171, 5112.514311140436, 5775.191473193672, 5790.0], "value": 4029.050333578132, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.4504690825165, 698.9405900498457, 717.3794667612515, 766.3983772738397, 812.419120328965, 15006.849931500681, 15820.525384238463, 15921.68156636868, 16246.187690615452, 16359.427420040316, 14435.711285774305, 14753.926230368834, 14760.114393136419, 14761.040532365416, 14780.113193208388, 686.7527690031585, 843.0599881132555, 872.1409411729442, 873.9650413983433, 875.011237301848, 603.6658983646147, 840.6343240690288, 865.208334374047, 874.8906386701663, 877.7235170921172, 914.6570036236411, 917.0142097245488, 918.0360621347592, 918.9862152067724, 920.3511524375299, 907.1790030022839, 910.535626830318, 910.5583791860943, 910.7677542226756, 912.0332447605526, 653.5980372071142, 669.7086767256259, 674.5345711459078, 674.7368526274756, 675.3347952267062, 14969.476068337555, 14998.100113993196, 15011.099334039993, 15037.323320450607, 15064.548063558112, 14344.282785860769, 14490.710185796224, 14510.637234069127, 14524.927375363055, 14836.3323650436, 11583.536658533649, 11625.631422880742, 11713.004394626467, 11787.587434439753, 11880.881191188151, 3194.88817891375, 3786.110264087937, 3850.711196660234, 3879.844806207748, 3994.560598334181, 97541.0, 98016.50991744996, 98081.50959245158, 99505.0, 101110.49444752802, 11151.553937842395, 11200.43997800123, 11289.096872250364, 11386.658400248005, 11391.316521008766, 22746.976386062666, 22795.772042279696, 22817.087316507153, 23100.65349019766, 23216.53566928652, 7942.126366099725, 7983.281504664608, 7994.960025199953, 7999.0, 8113.391495637851, 4389.84635537761, 4430.822767089345, 4469.21788686985, 4516.345129956138, 4544.772761361919, 3593.4789455528803, 3694.0949467380665, 3705.6850167735506, 3709.666130048309, 3733.178700685845, 656.9605823650501, 662.1722846441947, 666.4102269491437, 684.4319215051595, 684.6029303004245, 608.4402349838159, 650.7012122652767, 663.2754837422663, 670.4267850987336, 686.2588404523103, 7499.713732382147, 9511.857322140173, 9648.469334186688, 9672.177864881563, 9812.215022798158, 526.5182358142333, 529.4724719185102, 561.1526594841819, 573.9741711622987, 681.877262092828, 3381.5773028371455, 3728.9931718436414, 3841.750286231386, 4278.7004909656025, 5128.948710512922, 144729.0, 149551.0, 156171.0, 157939.0, 162760.37239627453, 110733.44633276782, 115055.0, 118890.0, 134778.0, 137787.6221237775, 72238.63880680563, 84587.0, 105039.0, 105848.0, 107450.46274768733, 9119.361644684808, 9953.303268771117, 10003.949980250052, 10023.198144148304, 10085.596576136872, 50283.99432011266, 54237.72881135727, 58138.0, 58888.70555647194, 59280.70359648174, 85587.57206214179, 88907.66638500558, 90685.54657226671, 91232.0, 94422.0, 11356.772864542498, 12865.678358041125, 13136.146150500186, 13259.403326850123, 13479.0, 14571.927140364654, 14642.341094650554, 14710.264486775832, 14826.036307639968, 15046.247687615794, 13409.0, 13545.32273386307, 13570.86429135696, 13922.303884805517, 14341.713165736419, 13562.050656453954, 13742.450301987808, 13802.378892950042, 13922.373493193034, 14128.431275394241, 13209.933950330187, 13390.397432115384, 13491.392887320291, 13594.320283985564, 13979.930100349433, 10658.573657053632, 10820.729481763019, 11375.26060806045, 11404.600838970597, 11722.296662200295, 10701.571937122428, 11347.489362978851, 11431.304555781444, 11610.88389116098, 11632.0], "value": 7763.213574254537, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 119.0, 118.0, 118.0, 118.0, 119.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 146.0, 106.0, 178.0, 113.0, 139.0, 109.0, 133.0, 162.0, 106.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 194.0, 210.0, 286.0, 182.0, 193.0, 268.0, 263.0, 197.0, 196.0], "value": 218.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 58.0, 59.0, 82.0, 59.0, 61.0, 51.0, 78.0, 89.0, 80.0], "value": 69.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 100.0, 116.0, 100.0, 68.0, 69.0, 88.0, 72.0, 69.0, 88.0], "value": 85.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 77.0, 136.0, 85.0, 102.0, 87.0, 117.0, 84.0, 134.0, 75.0], "value": 99.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 96.0, 98.0, 96.0, 109.0, 97.0, 97.0, 97.0, 98.0, 95.0], "value": 103.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 77.0, 132.0, 144.0, 132.0, 92.0, 80.0, 145.0, 148.0], "value": 111.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 55.0, 58.0, 58.0, 63.0, 89.0, 47.0, 51.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 74.0, 74.0, 73.0, 67.0, 69.0, 70.0, 69.0, 72.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 80.0, 84.0, 109.0, 108.0, 107.0, 89.0, 90.0, 88.0], "value": 93.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 151.0, 146.0, 142.0, 144.0, 150.0, 147.0, 184.0, 144.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 178.0, 174.0, 173.0, 176.0, 175.0, 175.0, 177.0, 176.0, 176.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 83.0, 93.0, 93.0, 76.0, 73.0, 98.0, 91.0, 94.0, 89.0], "value": 85.6, "unit": "score"}]}]} 15:04:14 INFO - Return code: 0 15:04:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:04:14 ERROR - # TBPL SUCCESS # 15:04:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:04:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:04:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:04:14 INFO - 2016-10-04 15:04:14.468 screenresolution[1678:10609] starting screenresolution argv=screenresolution get 15:04:14 INFO - 2016-10-04 15:04:14.471 screenresolution[1678:10609] Display 0: 1600x1200x32@60 15:04:14 INFO - 2016-10-04 15:04:14.477 screenresolution[1679:10612] starting screenresolution argv=screenresolution list 15:04:14 INFO - Available Modes on Display 0 15:04:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:04:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:04:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:04:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:04:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:04:14 INFO - Intel Iris: 15:04:14 INFO - Chipset Model: Intel Iris 15:04:14 INFO - Type: GPU 15:04:14 INFO - Bus: Built-In 15:04:14 INFO - VRAM (Dynamic, Max): 1536 MB 15:04:14 INFO - Vendor: Intel (0x8086) 15:04:14 INFO - Device ID: 0x0a2e 15:04:14 INFO - Revision ID: 0x0009 15:04:14 INFO - Displays: 15:04:14 INFO - Display: 15:04:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:04:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:04:14 INFO - Display Serial Number: 1600x1200 60 15:04:14 INFO - Main Display: Yes 15:04:14 INFO - Mirror: Off 15:04:14 INFO - Online: Yes 15:04:14 INFO - Rotation: Supported 15:04:14 INFO - Return code: 0 15:04:14 INFO - Running post-action listener: _resource_record_post_action 15:04:14 INFO - [mozharness: 2016-10-04 22:04:14.712226Z] Finished run-tests step (success) 15:04:14 INFO - Running post-run listener: _resource_record_post_run 15:04:14 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 38050304; Write bytes: 710779392; Read time: 254; Write time: 2008 15:04:14 INFO - TinderboxPrint: CPU usage
54.4% 15:04:14 INFO - TinderboxPrint: I/O read bytes / time
38,050,304 / 254 15:04:14 INFO - TinderboxPrint: I/O write bytes / time
710,779,392 / 2,008 15:04:14 INFO - TinderboxPrint: CPU idle
2,207.3 (45.6%) 15:04:14 INFO - TinderboxPrint: CPU system
981.9 (20.3%) 15:04:14 INFO - TinderboxPrint: CPU user
1,656.4 (34.2%) 15:04:14 INFO - TinderboxPrint: Swap in / out
445,558,784 / 0 15:04:14 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 399763968; Write bytes: 394582016; Read time: 30812; Write time: 792 15:04:14 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36043264; Write bytes: 299350528; Read time: 234; Write time: 1170 15:04:15 INFO - Running post-run listener: _upload_blobber_files 15:04:15 INFO - Blob upload gear active. 15:04:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:04:15 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 15:04:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:04:15 INFO - (blobuploader) - INFO - Open directory for files ... 15:04:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:04:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:04:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:04:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:04:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:04:16 INFO - (blobuploader) - INFO - Done attempting. 15:04:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:04:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:04:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:04:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:04:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:04:18 INFO - (blobuploader) - INFO - Done attempting. 15:04:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:04:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:04:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:04:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:04:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:04:20 INFO - (blobuploader) - INFO - Done attempting. 15:04:20 INFO - (blobuploader) - INFO - Iteration through files over. 15:04:20 INFO - Return code: 0 15:04:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:04:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:04:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f0f3d31d4a174c94fde82a67305a131ffe720850fe53001e63c08623dda58815b6cfc31815fdf1ffe81bfd16e60dc874809ac2348caf0d46888178d8e321e97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec8f02fddf17dbee9b143aac6b07ba7e384e3f45edea4f1756c1a91367bae019f7ceb0e5219ed0c54be27c0e6c2bb0303f854fef65c9f7acb478205a0e604e14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b5c1473a5d80185e6990fa5c0f19928241c3ec1ce5632ac2965d105da656bb58e609ede975d5e789fb209f7346d604e0ae8b34379468043211f6cdd17f90f844"} 15:04:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:04:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:04:20 INFO - Contents: 15:04:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f0f3d31d4a174c94fde82a67305a131ffe720850fe53001e63c08623dda58815b6cfc31815fdf1ffe81bfd16e60dc874809ac2348caf0d46888178d8e321e97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec8f02fddf17dbee9b143aac6b07ba7e384e3f45edea4f1756c1a91367bae019f7ceb0e5219ed0c54be27c0e6c2bb0303f854fef65c9f7acb478205a0e604e14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b5c1473a5d80185e6990fa5c0f19928241c3ec1ce5632ac2965d105da656bb58e609ede975d5e789fb209f7346d604e0ae8b34379468043211f6cdd17f90f844"} 15:04:20 INFO - Running post-run listener: copy_logs_to_upload_dir 15:04:20 INFO - Copying logs to upload dir... 15:04:20 INFO - mkdir: /builds/slave/test/build/upload/logs 15:04:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.573297 ========= master_lag: 2.63 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-04 15:04:22.815518) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 15:04:22.825225) ========= 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.bL77nRpOvF/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.i5goNQsdu4/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f0f3d31d4a174c94fde82a67305a131ffe720850fe53001e63c08623dda58815b6cfc31815fdf1ffe81bfd16e60dc874809ac2348caf0d46888178d8e321e97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec8f02fddf17dbee9b143aac6b07ba7e384e3f45edea4f1756c1a91367bae019f7ceb0e5219ed0c54be27c0e6c2bb0303f854fef65c9f7acb478205a0e604e14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b5c1473a5d80185e6990fa5c0f19928241c3ec1ce5632ac2965d105da656bb58e609ede975d5e789fb209f7346d604e0ae8b34379468043211f6cdd17f90f844"} build_url:https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010875 build_url: 'https://queue.taskcluster.net/v1/task/eFH54ZqnSzeybO1XrNixGQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f0f3d31d4a174c94fde82a67305a131ffe720850fe53001e63c08623dda58815b6cfc31815fdf1ffe81bfd16e60dc874809ac2348caf0d46888178d8e321e97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec8f02fddf17dbee9b143aac6b07ba7e384e3f45edea4f1756c1a91367bae019f7ceb0e5219ed0c54be27c0e6c2bb0303f854fef65c9f7acb478205a0e604e14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b5c1473a5d80185e6990fa5c0f19928241c3ec1ce5632ac2965d105da656bb58e609ede975d5e789fb209f7346d604e0ae8b34379468043211f6cdd17f90f844"}' ========= master_lag: 0.61 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 15:04:23.444564) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:04:23.451091) ========= 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.bL77nRpOvF/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.i5goNQsdu4/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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.004470 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 15:04:23.480325) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 15:04:23.480674) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 15:04:23.481074) ========= ========= Total master_lag: 3.33 =========