builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0173 starttime: 1493806504.43 results: success (0) buildid: 20170503011221 builduid: 7cca6dc31462461f84e88ee29d7c1fed revision: 82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 03:15:04.429431) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 03:15:04.429842) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 03:15:04.430126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 03:15:04.454558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 03:15:04.454933) ========= 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.67ADPSWVHF/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.1e0BeqaVYW/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 --2017-05-03 03:15:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.1M=0.001s 2017-05-03 03:15:04 (11.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127344 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 03:15:04.607271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 03:15:04.607600) ========= 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.67ADPSWVHF/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.1e0BeqaVYW/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.027874 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 03:15:04.656382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 03:15:04.656747) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.67ADPSWVHF/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.1e0BeqaVYW/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 2017-05-03 03:15:04,777 truncating revision to first 12 chars 2017-05-03 03:15:04,777 Setting DEBUG logging. 2017-05-03 03:15:04,777 attempt 1/10 2017-05-03 03:15:04,777 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/82c2d17e74ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 03:15:05,855 unpacking tar archive at: mozilla-central-82c2d17e74ef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.344700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 03:15:06.026438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 03:15:06.026760) ========= script_repo_revision: 82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 03:15:06.027177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 03:15:06.027461) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 03:15:06.047767) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-05-03 03:15:06.048080) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.67ADPSWVHF/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.1e0BeqaVYW/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 03:15:06 INFO - MultiFileLogger online at 20170503 03:15:06 in /builds/slave/test 03:15:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:15:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:15:06 INFO - {'append_to_log': False, 03:15:06 INFO - 'base_work_dir': '/builds/slave/test', 03:15:06 INFO - 'blob_upload_branch': 'Firefox', 03:15:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:15:06 INFO - 'branch': 'Firefox', 03:15:06 INFO - 'buildbot_json_path': 'buildprops.json', 03:15:06 INFO - 'config_files': ('talos/mac_config.py',), 03:15:06 INFO - 'default_actions': ('clobber', 03:15:06 INFO - 'read-buildbot-config', 03:15:06 INFO - 'download-and-extract', 03:15:06 INFO - 'populate-webroot', 03:15:06 INFO - 'create-virtualenv', 03:15:06 INFO - 'install', 03:15:06 INFO - 'run-tests'), 03:15:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:15:06 INFO - 'download_minidump_stackwalk': True, 03:15:06 INFO - 'download_symbols': 'ondemand', 03:15:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:15:06 INFO - 'tooltool.py': '/tools/tooltool.py', 03:15:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:15:06 INFO - '/tools/misc-python/virtualenv.py')}, 03:15:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:15:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:15:06 INFO - 'gecko_profile': False, 03:15:06 INFO - 'gecko_profile_interval': 0, 03:15:06 INFO - 'installer_path': 'installer.exe', 03:15:06 INFO - 'log_level': 'info', 03:15:06 INFO - 'log_name': 'talos', 03:15:06 INFO - 'log_to_console': True, 03:15:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:15:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:15:06 INFO - 'opt_config_files': (), 03:15:06 INFO - 'pip_index': False, 03:15:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:15:06 INFO - 'cmd': ('bash', 03:15:06 INFO - '-c', 03:15:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:15:06 INFO - 'enabled': True, 03:15:06 INFO - 'halt_on_failure': False, 03:15:06 INFO - 'name': 'check_screen_resolution'},), 03:15:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:15:06 INFO - 'cmd': ('bash', 03:15:06 INFO - '-c', 03:15:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:15:06 INFO - 'enabled': True, 03:15:06 INFO - 'halt_on_failure': False, 03:15:06 INFO - 'name': 'check_screen_resolution'},), 03:15:06 INFO - 'run_cmd_checks_enabled': True, 03:15:06 INFO - 'suite': 'dromaeojs-e10s', 03:15:06 INFO - 'system_bits': '32', 03:15:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:15:06 INFO - 'title': 't-yosemite-r7-0173', 03:15:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:15:06 INFO - 'use_talos_json': True, 03:15:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:15:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:15:06 INFO - 'work_dir': 'build'} 03:15:06 INFO - [mozharness: 2017-05-03 10:15:06.283495Z] Running clobber step. 03:15:06 INFO - Running pre-action listener: _resource_record_pre_action 03:15:06 INFO - Running main action method: clobber 03:15:06 INFO - rmtree: /builds/slave/test/build 03:15:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:15:08 INFO - Running post-action listener: _resource_record_post_action 03:15:08 INFO - [mozharness: 2017-05-03 10:15:08.892266Z] Finished clobber step (success) 03:15:08 INFO - [mozharness: 2017-05-03 10:15:08.892392Z] Running read-buildbot-config step. 03:15:08 INFO - Running pre-action listener: _resource_record_pre_action 03:15:08 INFO - Running main action method: read_buildbot_config 03:15:08 INFO - Using buildbot properties: 03:15:08 INFO - { 03:15:08 INFO - "project": "", 03:15:08 INFO - "product": "firefox", 03:15:08 INFO - "script_repo_revision": "production", 03:15:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:15:08 INFO - "repository": "", 03:15:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:15:08 INFO - "buildid": "20170503011221", 03:15:08 INFO - "pgo_build": "False", 03:15:08 INFO - "basedir": "/builds/slave/test", 03:15:08 INFO - "buildnumber": 61, 03:15:08 INFO - "slavename": "t-yosemite-r7-0173", 03:15:08 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:15:08 INFO - "platform": "yosemite_r7", 03:15:08 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:15:08 INFO - "branch": "mozilla-central", 03:15:08 INFO - "repo_path": "mozilla-central", 03:15:08 INFO - "revision": "82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4", 03:15:08 INFO - "stage_platform": "macosx64", 03:15:08 INFO - "builduid": "7cca6dc31462461f84e88ee29d7c1fed", 03:15:08 INFO - "slavebuilddir": "test" 03:15:08 INFO - } 03:15:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:15:08 INFO - Running post-action listener: _resource_record_post_action 03:15:08 INFO - [mozharness: 2017-05-03 10:15:08.895716Z] Finished read-buildbot-config step (success) 03:15:08 INFO - [mozharness: 2017-05-03 10:15:08.895805Z] Running download-and-extract step. 03:15:08 INFO - Running pre-action listener: _resource_record_pre_action 03:15:08 INFO - Running main action method: download_and_extract 03:15:08 INFO - mkdir: /builds/slave/test/build/tests 03:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:08 INFO - trying https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:15:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:15:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 03:15:10 INFO - Downloaded 1325 bytes. 03:15:10 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:15:10 INFO - Using the following test package requirements: 03:15:10 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:15:10 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:15:10 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:15:10 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:15:10 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:15:10 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:15:10 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:15:10 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:15:10 INFO - u'jsshell-mac.zip'], 03:15:10 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:15:10 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:15:10 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:15:10 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:15:10 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:15:10 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:15:10 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:15:10 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:15:10 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:15:10 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:15:10 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:15:10 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:15:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:15:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:15:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:15:12 INFO - Content-Length response header: 52700171 03:15:12 INFO - Bytes received: 52700171 03:15:28 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:15:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:15:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:15:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:15:30 INFO - Content-Length response header: 52700171 03:15:30 INFO - Bytes received: 52700171 03:15:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:15:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:15:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:15:46 INFO - Content-Length response header: 14408811 03:15:46 INFO - Bytes received: 14408811 03:15:47 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')]} 03:15:47 INFO - trying https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:15:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:15:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 03:15:49 INFO - Downloaded 71194606 bytes. 03:15:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:15:49 INFO - mkdir: /builds/slave/test/properties 03:15:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:15:49 INFO - Writing to file /builds/slave/test/properties/build_url 03:15:49 INFO - Contents: 03:15:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:15:49 INFO - Running post-action listener: _resource_record_post_action 03:15:49 INFO - Running post-action listener: set_extra_try_arguments 03:15:49 INFO - [mozharness: 2017-05-03 10:15:49.855682Z] Finished download-and-extract step (success) 03:15:49 INFO - [mozharness: 2017-05-03 10:15:49.855801Z] Running populate-webroot step. 03:15:49 INFO - Running pre-action listener: _resource_record_pre_action 03:15:49 INFO - Running main action method: populate_webroot 03:15:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:15:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:15:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:15:49 INFO - '--tppagecycles', 03:15:49 INFO - '7'], 03:15:49 INFO - 'tests': ['tsvgm']}}, 03:15:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:15:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:15:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:15:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:15:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:15:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:15:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:15:49 INFO - 'talos_options': ['--disable-e10s'], 03:15:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:15:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:15:49 INFO - 'talos_options': ['--disable-e10s'], 03:15:49 INFO - 'tests': ['damp', 'tps']}, 03:15:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:15:49 INFO - 'tests': ['damp', 'tps']}, 03:15:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:15:49 INFO - 'tests': ['dromaeo_dom']}, 03:15:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:15:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:15:49 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:15:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:15:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:15:49 INFO - 'tests': ['a11yr', 03:15:49 INFO - 'ts_paint', 03:15:49 INFO - 'tpaint', 03:15:49 INFO - 'sessionrestore', 03:15:49 INFO - 'sessionrestore_no_auto_restore', 03:15:49 INFO - 'tabpaint']}, 03:15:49 INFO - 'other-e10s': {'tests': ['a11yr', 03:15:49 INFO - 'ts_paint', 03:15:49 INFO - 'tpaint', 03:15:49 INFO - 'sessionrestore', 03:15:49 INFO - 'sessionrestore_no_auto_restore', 03:15:49 INFO - 'tabpaint']}, 03:15:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:15:49 INFO - 'ts_paint', 03:15:49 INFO - 'tpaint', 03:15:49 INFO - 'sessionrestore', 03:15:49 INFO - 'sessionrestore_no_auto_restore', 03:15:49 INFO - 'tabpaint']}, 03:15:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:15:49 INFO - 'ts_paint', 03:15:49 INFO - 'tpaint', 03:15:49 INFO - 'sessionrestore', 03:15:49 INFO - 'sessionrestore_no_auto_restore', 03:15:49 INFO - 'tabpaint']}, 03:15:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:15:49 INFO - 'tests': ['a11yr', 03:15:49 INFO - 'ts_paint', 03:15:49 INFO - 'tpaint', 03:15:49 INFO - 'sessionrestore', 03:15:49 INFO - 'sessionrestore_no_auto_restore', 03:15:49 INFO - 'tabpaint']}, 03:15:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:15:49 INFO - 'tests': ['a11yr', 03:15:49 INFO - 'ts_paint', 03:15:49 INFO - 'tpaint', 03:15:49 INFO - 'sessionrestore', 03:15:49 INFO - 'sessionrestore_no_auto_restore', 03:15:49 INFO - 'tabpaint']}, 03:15:49 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:15:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:15:49 INFO - 'bloom_basic_ref']}, 03:15:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:15:49 INFO - 'tests': ['tsvgx', 03:15:49 INFO - 'tsvgr_opacity', 03:15:49 INFO - 'tart', 03:15:49 INFO - 'tscrollx', 03:15:49 INFO - 'cart', 03:15:49 INFO - 'tsvg_static']}, 03:15:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:15:49 INFO - 'tsvgr_opacity', 03:15:49 INFO - 'tart', 03:15:49 INFO - 'tscrollx', 03:15:49 INFO - 'cart', 03:15:49 INFO - 'tsvg_static']}, 03:15:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:15:49 INFO - 'talos_options': ['--disable-e10s'], 03:15:49 INFO - 'tests': ['tp5o']}, 03:15:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:15:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:15:49 INFO - 'talos_options': ['--disable-e10s', 03:15:49 INFO - '--xperf_path', 03:15:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:49 INFO - 'tests': ['tp5n']}, 03:15:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:15:49 INFO - 'talos_options': ['--xperf_path', 03:15:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:49 INFO - 'tests': ['tp5n']}}, 03:15:49 INFO - 'talos.zip': {'path': '', 03:15:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:15:49 INFO - Running post-action listener: _resource_record_post_action 03:15:49 INFO - [mozharness: 2017-05-03 10:15:49.874915Z] Finished populate-webroot step (success) 03:15:49 INFO - [mozharness: 2017-05-03 10:15:49.875023Z] Running create-virtualenv step. 03:15:49 INFO - Running pre-action listener: _resource_record_pre_action 03:15:49 INFO - Running main action method: create_virtualenv 03:15:49 INFO - Creating virtualenv /builds/slave/test/build/venv 03:15:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:15:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:15:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:15:50 INFO - Using real prefix '/tools/python27' 03:15:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:15:50 INFO - Installing distribute.............................................................................................................................................................................................done. 03:15:53 INFO - Installing pip.................done. 03:15:53 INFO - Return code: 0 03:15:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:15:53 INFO - Reading from file tmpfile_stdout 03:15:53 INFO - Output received: 03:15:53 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:15:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1029f9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029fc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f343c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027d7d30>, '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 0x1026fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ccbe8>, '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.67ADPSWVHF/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.1e0BeqaVYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 03:15:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:15:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.67ADPSWVHF/Render', 03:15:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:53 INFO - 'HOME': '/Users/cltbld', 03:15:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:53 INFO - 'LOGNAME': 'cltbld', 03:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:53 INFO - 'MOZ_NO_REMOTE': '1', 03:15:53 INFO - 'NO_EM_RESTART': '1', 03:15:53 INFO - 'PAGER': '/bin/cat', 03:15:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:53 INFO - 'PWD': '/builds/slave/test', 03:15:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:53 INFO - 'SHELL': '/bin/bash', 03:15:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1e0BeqaVYW/Listeners', 03:15:53 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 03:15:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:53 INFO - 'USER': 'cltbld', 03:15:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:53 INFO - 'XPC_FLAGS': '0x0', 03:15:53 INFO - 'XPC_SERVICE_NAME': '0', 03:15:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:54 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 03:15:54 INFO - Cleaning up... 03:15:54 INFO - Return code: 0 03:15:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:54 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 0x1029f9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029fc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f343c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027d7d30>, '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 0x1026fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ccbe8>, '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.67ADPSWVHF/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.1e0BeqaVYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 03:15:54 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 03:15:54 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 03:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.67ADPSWVHF/Render', 03:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:54 INFO - 'HOME': '/Users/cltbld', 03:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:54 INFO - 'LOGNAME': 'cltbld', 03:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:54 INFO - 'MOZ_NO_REMOTE': '1', 03:15:54 INFO - 'NO_EM_RESTART': '1', 03:15:54 INFO - 'PAGER': '/bin/cat', 03:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:54 INFO - 'PWD': '/builds/slave/test', 03:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:54 INFO - 'SHELL': '/bin/bash', 03:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1e0BeqaVYW/Listeners', 03:15:54 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 03:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:54 INFO - 'USER': 'cltbld', 03:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:54 INFO - 'XPC_FLAGS': '0x0', 03:15:54 INFO - 'XPC_SERVICE_NAME': '0', 03:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:54 INFO - Downloading/unpacking psutil>=3.1.1 03:15:54 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 03:15:54 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 03:15:54 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 03:15:54 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 03:15:54 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 03:15:54 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 03:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:15:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:56 INFO - Installing collected packages: psutil 03:15:56 INFO - Running setup.py install for psutil 03:15:56 INFO - building 'psutil._psutil_osx' extension 03:15:56 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 03:15:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:15:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:15:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:15:57 INFO - building 'psutil._psutil_posix' extension 03:15:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:15:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:15:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:15:57 INFO - ^ 03:15:57 INFO - 1 warning generated. 03:15:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:15:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:57 INFO - Successfully installed psutil 03:15:57 INFO - Cleaning up... 03:15:57 INFO - Return code: 0 03:15:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:15:57 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')]} 03:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:57 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')]} 03:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:57 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 0x1029f9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029fc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f343c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027d7d30>, '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 0x1026fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ccbe8>, '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.67ADPSWVHF/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.1e0BeqaVYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 03:15:57 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 03:15:57 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 03:15:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.67ADPSWVHF/Render', 03:15:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:57 INFO - 'HOME': '/Users/cltbld', 03:15:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:57 INFO - 'LOGNAME': 'cltbld', 03:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:57 INFO - 'MOZ_NO_REMOTE': '1', 03:15:57 INFO - 'NO_EM_RESTART': '1', 03:15:57 INFO - 'PAGER': '/bin/cat', 03:15:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:57 INFO - 'PWD': '/builds/slave/test', 03:15:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:57 INFO - 'SHELL': '/bin/bash', 03:15:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1e0BeqaVYW/Listeners', 03:15:57 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 03:15:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:57 INFO - 'USER': 'cltbld', 03:15:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:57 INFO - 'XPC_FLAGS': '0x0', 03:15:57 INFO - 'XPC_SERVICE_NAME': '0', 03:15:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:15:59 INFO - Installing collected packages: mozsystemmonitor 03:15:59 INFO - Running setup.py install for mozsystemmonitor 03:15:59 INFO - Successfully installed mozsystemmonitor 03:15:59 INFO - Cleaning up... 03:15:59 INFO - Return code: 0 03:15:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:15:59 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')]} 03:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:59 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')]} 03:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:59 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 0x1029f9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029fc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f343c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027d7d30>, '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 0x1026fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ccbe8>, '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.67ADPSWVHF/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.1e0BeqaVYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 03:15:59 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 03:15:59 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 03:15:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.67ADPSWVHF/Render', 03:15:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:59 INFO - 'HOME': '/Users/cltbld', 03:15:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:59 INFO - 'LOGNAME': 'cltbld', 03:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:59 INFO - 'MOZ_NO_REMOTE': '1', 03:15:59 INFO - 'NO_EM_RESTART': '1', 03:15:59 INFO - 'PAGER': '/bin/cat', 03:15:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:59 INFO - 'PWD': '/builds/slave/test', 03:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:59 INFO - 'SHELL': '/bin/bash', 03:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1e0BeqaVYW/Listeners', 03:15:59 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 03:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:59 INFO - 'USER': 'cltbld', 03:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:59 INFO - 'XPC_FLAGS': '0x0', 03:15:59 INFO - 'XPC_SERVICE_NAME': '0', 03:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:00 INFO - Downloading/unpacking jsonschema==2.5.1 03:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:16:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:16:02 INFO - warning: no files found matching '*.txt' 03:16:02 INFO - no previously-included directories found matching 'build' 03:16:02 INFO - no previously-included directories found matching 'dist' 03:16:02 INFO - no previously-included directories found matching '.git*' 03:16:02 INFO - Installing collected packages: jsonschema, functools32 03:16:02 INFO - Running setup.py install for functools32 03:16:02 INFO - warning: no files found matching '*.txt' 03:16:02 INFO - no previously-included directories found matching 'build' 03:16:02 INFO - no previously-included directories found matching 'dist' 03:16:02 INFO - no previously-included directories found matching '.git*' 03:16:02 INFO - Successfully installed jsonschema functools32 03:16:02 INFO - Cleaning up... 03:16:02 INFO - Return code: 0 03:16:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:16:02 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')]} 03:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:02 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')]} 03:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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', '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 0x1029f9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029fc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f343c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027d7d30>, '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 0x1026fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ccbe8>, '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.67ADPSWVHF/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.1e0BeqaVYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 03:16: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:16: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 functools32==3.2.3-2 03:16:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.67ADPSWVHF/Render', 03:16:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:02 INFO - 'HOME': '/Users/cltbld', 03:16:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:02 INFO - 'LOGNAME': 'cltbld', 03:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:02 INFO - 'MOZ_NO_REMOTE': '1', 03:16:02 INFO - 'NO_EM_RESTART': '1', 03:16:02 INFO - 'PAGER': '/bin/cat', 03:16:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:02 INFO - 'PWD': '/builds/slave/test', 03:16:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:02 INFO - 'SHELL': '/bin/bash', 03:16:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1e0BeqaVYW/Listeners', 03:16:02 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 03:16:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:02 INFO - 'USER': 'cltbld', 03:16:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:02 INFO - 'XPC_FLAGS': '0x0', 03:16:02 INFO - 'XPC_SERVICE_NAME': '0', 03:16:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:16:03 INFO - Cleaning up... 03:16:03 INFO - Return code: 0 03:16:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:03 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 0x1029f9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029fc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f343c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027d7d30>, '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 0x1026fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ccbe8>, '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.67ADPSWVHF/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.1e0BeqaVYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 03:16:03 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 03:16:03 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 03:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.67ADPSWVHF/Render', 03:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:03 INFO - 'HOME': '/Users/cltbld', 03:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:03 INFO - 'LOGNAME': 'cltbld', 03:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:03 INFO - 'MOZ_NO_REMOTE': '1', 03:16:03 INFO - 'NO_EM_RESTART': '1', 03:16:03 INFO - 'PAGER': '/bin/cat', 03:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:03 INFO - 'PWD': '/builds/slave/test', 03:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:03 INFO - 'SHELL': '/bin/bash', 03:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1e0BeqaVYW/Listeners', 03:16:03 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 03:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:03 INFO - 'USER': 'cltbld', 03:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:03 INFO - 'XPC_FLAGS': '0x0', 03:16:03 INFO - 'XPC_SERVICE_NAME': '0', 03:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:16:03 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 03:16:03 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 03:16:03 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 03:16:03 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 03:16:03 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 03:16:03 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 03:16:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:16:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:06 INFO - Downloading docopt-0.6.1.tar.gz 03:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:06 INFO - Running setup.py install for blobuploader 03:16:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:16:06 INFO - Running setup.py install for requests 03:16:07 INFO - Running setup.py install for docopt 03:16:07 INFO - Successfully installed blobuploader requests docopt 03:16:07 INFO - Cleaning up... 03:16:07 INFO - Return code: 0 03:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:07 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')]} 03:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:07 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')]} 03:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:07 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 0x1029f9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029fc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f343c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027d7d30>, '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 0x1026fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ccbe8>, '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.67ADPSWVHF/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.1e0BeqaVYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 03:16:07 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 03:16:07 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 03:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.67ADPSWVHF/Render', 03:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:07 INFO - 'HOME': '/Users/cltbld', 03:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:07 INFO - 'LOGNAME': 'cltbld', 03:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:07 INFO - 'MOZ_NO_REMOTE': '1', 03:16:07 INFO - 'NO_EM_RESTART': '1', 03:16:07 INFO - 'PAGER': '/bin/cat', 03:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:07 INFO - 'PWD': '/builds/slave/test', 03:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:07 INFO - 'SHELL': '/bin/bash', 03:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1e0BeqaVYW/Listeners', 03:16:07 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 03:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:07 INFO - 'USER': 'cltbld', 03:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:07 INFO - 'XPC_FLAGS': '0x0', 03:16:07 INFO - 'XPC_SERVICE_NAME': '0', 03:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:07 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-O0nejh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:07 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-6mtZyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:07 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-ZwMXgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:07 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-bIL84c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:08 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-mW_QoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:08 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-qk1TKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:08 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-N82gMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:08 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-l1lc9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:08 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-c_Lp0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:08 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-LtDh2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:08 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-D7qEmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:08 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-EgdJOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:08 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-llOgX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:08 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-C2YgTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:09 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Jq6Uyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:09 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-QpkxhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:09 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-xBNOM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:09 INFO - Running setup.py install for manifestparser 03:16:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Running setup.py install for mozcrash 03:16:09 INFO - Running setup.py install for mozdebug 03:16:09 INFO - Running setup.py install for mozdevice 03:16:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:16:09 INFO - Running setup.py install for mozfile 03:16:10 INFO - Running setup.py install for mozhttpd 03:16:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:16:10 INFO - Running setup.py install for mozinfo 03:16:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:16:10 INFO - Running setup.py install for mozInstall 03:16:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:16:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:16:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:16:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:16:10 INFO - Running setup.py install for mozleak 03:16:10 INFO - Running setup.py install for mozlog 03:16:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:16:10 INFO - Running setup.py install for moznetwork 03:16:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:16:10 INFO - Running setup.py install for mozprocess 03:16:11 INFO - Running setup.py install for mozprofile 03:16:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:16:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:16:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:16:11 INFO - Running setup.py install for mozrunner 03:16:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:16:11 INFO - Running setup.py install for mozscreenshot 03:16:11 INFO - Running setup.py install for moztest 03:16:11 INFO - Running setup.py install for mozversion 03:16:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:16:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:11 INFO - Cleaning up... 03:16:11 INFO - Return code: 0 03:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:11 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 0x1029f9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029fc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f343c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027d7d30>, '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 0x1026fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ccbe8>, '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.67ADPSWVHF/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.1e0BeqaVYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 03:16:11 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 03:16:11 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 03:16:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.67ADPSWVHF/Render', 03:16:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:11 INFO - 'HOME': '/Users/cltbld', 03:16:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:11 INFO - 'LOGNAME': 'cltbld', 03:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:11 INFO - 'MOZ_NO_REMOTE': '1', 03:16:11 INFO - 'NO_EM_RESTART': '1', 03:16:11 INFO - 'PAGER': '/bin/cat', 03:16:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:11 INFO - 'PWD': '/builds/slave/test', 03:16:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:11 INFO - 'SHELL': '/bin/bash', 03:16:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1e0BeqaVYW/Listeners', 03:16:11 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 03:16:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:11 INFO - 'USER': 'cltbld', 03:16:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:11 INFO - 'XPC_FLAGS': '0x0', 03:16:11 INFO - 'XPC_SERVICE_NAME': '0', 03:16:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:12 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-TGU6V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:12 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)) 03:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:12 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-bTKyr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:12 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-MEi58G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:12 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)) 03:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:12 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-ghp7BF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 03:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:12 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-YUktEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:12 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)) 03:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:12 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-sgV4ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:12 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)) 03:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:12 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-E2Lqba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:12 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)) 03:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:12 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-CUJq2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:13 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)) 03:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:13 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-OAxq_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:13 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)) 03:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:13 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-wYWg2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:13 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)) 03:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:13 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-T3ASN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:13 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)) 03:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:13 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-iUBf1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 03:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:13 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-6IrNoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:13 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)) 03:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:13 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-0_cc8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:13 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-bg_Sn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:13 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)) 03:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:13 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-lQdYt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 03:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:13 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-yy6Ms9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:14 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)) 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:14 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)) 03:16:14 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:14 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 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 03:16:14 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 03:16:15 INFO - Downloading blessings-1.6.tar.gz 03:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:15 INFO - Installing collected packages: blessings 03:16:15 INFO - Running setup.py install for blessings 03:16:15 INFO - Successfully installed blessings 03:16:15 INFO - Cleaning up... 03:16:15 INFO - Return code: 0 03:16:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:15 INFO - Reading from file tmpfile_stdout 03:16:15 INFO - Current package versions: 03:16:15 INFO - blessings == 1.6 03:16:15 INFO - blobuploader == 1.2.4 03:16:15 INFO - docopt == 0.6.1 03:16:15 INFO - functools32 == 3.2.3-2 03:16:15 INFO - jsonschema == 2.5.1 03:16:15 INFO - manifestparser == 1.1 03:16:15 INFO - mozInstall == 1.12 03:16:15 INFO - mozcrash == 1.0 03:16:15 INFO - mozdebug == 0.1 03:16:15 INFO - mozdevice == 0.50 03:16:15 INFO - mozfile == 1.2 03:16:15 INFO - mozhttpd == 0.7 03:16:15 INFO - mozinfo == 0.9 03:16:15 INFO - mozleak == 0.1 03:16:15 INFO - mozlog == 3.4 03:16:15 INFO - moznetwork == 0.27 03:16:15 INFO - mozprocess == 0.25 03:16:15 INFO - mozprofile == 0.28 03:16:15 INFO - mozrunner == 6.13 03:16:15 INFO - mozscreenshot == 0.1 03:16:15 INFO - mozsystemmonitor == 0.3 03:16:15 INFO - moztest == 0.8 03:16:15 INFO - mozversion == 1.4 03:16:15 INFO - psutil == 3.1.1 03:16:15 INFO - requests == 1.2.3 03:16:15 INFO - wsgiref == 0.1.2 03:16:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:15 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')]} 03:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:15 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')]} 03:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:15 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 0x1029f9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029fc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f343c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027d7d30>, '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 0x1026fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ccbe8>, '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.67ADPSWVHF/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.1e0BeqaVYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 03:16:15 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 03:16:15 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 03:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.67ADPSWVHF/Render', 03:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:15 INFO - 'HOME': '/Users/cltbld', 03:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:15 INFO - 'LOGNAME': 'cltbld', 03:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:15 INFO - 'MOZ_NO_REMOTE': '1', 03:16:15 INFO - 'NO_EM_RESTART': '1', 03:16:15 INFO - 'PAGER': '/bin/cat', 03:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:15 INFO - 'PWD': '/builds/slave/test', 03:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:15 INFO - 'SHELL': '/bin/bash', 03:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1e0BeqaVYW/Listeners', 03:16:15 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 03:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:15 INFO - 'USER': 'cltbld', 03:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:15 INFO - 'XPC_FLAGS': '0x0', 03:16:15 INFO - 'XPC_SERVICE_NAME': '0', 03:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:16 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)) 03:16:16 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)) 03:16:16 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)) 03:16:16 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)) 03:16:16 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)) 03:16:16 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)) 03:16:16 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)) 03:16:16 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)) 03:16:16 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)) 03:16:16 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)) 03:16:16 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)) 03:16:16 INFO - Cleaning up... 03:16:16 INFO - Return code: 0 03:16:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1029f9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029fc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6f343c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027d7d30>, '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 0x1026fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ccbe8>, '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.67ADPSWVHF/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.1e0BeqaVYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 03:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:16:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.67ADPSWVHF/Render', 03:16:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:16 INFO - 'HOME': '/Users/cltbld', 03:16:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:16 INFO - 'LOGNAME': 'cltbld', 03:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:16 INFO - 'MOZ_NO_REMOTE': '1', 03:16:16 INFO - 'NO_EM_RESTART': '1', 03:16:16 INFO - 'PAGER': '/bin/cat', 03:16:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:16 INFO - 'PWD': '/builds/slave/test', 03:16:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:16 INFO - 'SHELL': '/bin/bash', 03:16:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1e0BeqaVYW/Listeners', 03:16:16 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 03:16:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:16 INFO - 'USER': 'cltbld', 03:16:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:16 INFO - 'XPC_FLAGS': '0x0', 03:16:16 INFO - 'XPC_SERVICE_NAME': '0', 03:16:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:16:16 INFO - Cleaning up... 03:16:16 INFO - Return code: 0 03:16:16 INFO - Running post-action listener: _resource_record_post_action 03:16:16 INFO - Running post-action listener: _start_resource_monitoring 03:16:16 INFO - Starting resource monitoring. 03:16:16 INFO - [mozharness: 2017-05-03 10:16:16.547816Z] Finished create-virtualenv step (success) 03:16:16 INFO - [mozharness: 2017-05-03 10:16:16.548785Z] Running install step. 03:16:16 INFO - Running pre-action listener: _resource_record_pre_action 03:16:16 INFO - Running main action method: install 03:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:16 INFO - Reading from file tmpfile_stdout 03:16:16 INFO - Detecting whether we're running mozinstall >=1.0... 03:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:16:16 INFO - Reading from file tmpfile_stdout 03:16:16 INFO - Output received: 03:16:16 INFO - Usage: mozinstall [options] installer 03:16:16 INFO - Options: 03:16:16 INFO - -h, --help show this help message and exit 03:16:16 INFO - -d DEST, --destination=DEST 03:16:16 INFO - Directory to install application into. [default: 03:16:16 INFO - "/builds/slave/test"] 03:16:16 INFO - --app=APP Application being installed. [default: firefox] 03:16:16 INFO - mkdir: /builds/slave/test/build/application 03:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:16:36 INFO - Reading from file tmpfile_stdout 03:16:36 INFO - Output received: 03:16:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:16:36 INFO - Running post-action listener: _resource_record_post_action 03:16:36 INFO - [mozharness: 2017-05-03 10:16:36.670727Z] Finished install step (success) 03:16:36 INFO - [mozharness: 2017-05-03 10:16:36.670873Z] Running run-tests step. 03:16:36 INFO - Running pre-action listener: _resource_record_pre_action 03:16:36 INFO - Running main action method: run_tests 03:16:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:16:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:16:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:16:36 INFO - 2017-05-03 03:16:36.685 screenresolution[1620:7276] starting screenresolution argv=screenresolution get 03:16:36 INFO - 2017-05-03 03:16:36.687 screenresolution[1620:7276] Display 0: 1600x1200x32@60 03:16:36 INFO - 2017-05-03 03:16:36.693 screenresolution[1621:7278] starting screenresolution argv=screenresolution list 03:16:36 INFO - Available Modes on Display 0 03:16:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:16:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:16:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:16:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:16:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:16:36 INFO - Intel Iris: 03:16:36 INFO - Chipset Model: Intel Iris 03:16:36 INFO - Type: GPU 03:16:36 INFO - Bus: Built-In 03:16:36 INFO - VRAM (Dynamic, Max): 1536 MB 03:16:36 INFO - Vendor: Intel (0x8086) 03:16:36 INFO - Device ID: 0x0a2e 03:16:36 INFO - Revision ID: 0x0009 03:16:36 INFO - Displays: 03:16:36 INFO - Display: 03:16:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:16:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:16:36 INFO - Display Serial Number: 1600x1200 60 03:16:36 INFO - Main Display: Yes 03:16:36 INFO - Mirror: Off 03:16:36 INFO - Online: Yes 03:16:36 INFO - Rotation: Supported 03:16:36 INFO - Return code: 0 03:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:36 INFO - Python 2.7.3 03:16:36 INFO - Return code: 0 03:16:36 INFO - grabbing minidump binary from tooltool 03:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:36 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 0x1027d7d30>, '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 0x1026fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1027ccbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:36 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 03:16:36 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 03:16:36 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 03:16:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:37 INFO - Return code: 0 03:16:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:16:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:37 INFO - ENV: RUST_BACKTRACE is now 1 03:16:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:16:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--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 03:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0173 --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 03:16:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.67ADPSWVHF/Render', 03:16:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:37 INFO - 'HOME': '/Users/cltbld', 03:16:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:37 INFO - 'LOGNAME': 'cltbld', 03:16:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:37 INFO - 'MOZ_NO_REMOTE': '1', 03:16:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:37 INFO - 'NO_EM_RESTART': '1', 03:16:37 INFO - 'PAGER': '/bin/cat', 03:16:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:37 INFO - 'PWD': '/builds/slave/test', 03:16:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:37 INFO - 'RUST_BACKTRACE': '1', 03:16:37 INFO - 'SHELL': '/bin/bash', 03:16:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1e0BeqaVYW/Listeners', 03:16:37 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 03:16:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:37 INFO - 'USER': 'cltbld', 03:16:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:37 INFO - 'XPC_FLAGS': '0x0', 03:16:37 INFO - 'XPC_SERVICE_NAME': '0', 03:16:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--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 03:16:37 INFO - mozversion application_buildid: 20170503011221 03:16:37 INFO - mozversion application_changeset: 82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4 03:16:37 INFO - mozversion application_display_name: Nightly 03:16:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:37 INFO - mozversion application_name: Firefox 03:16:37 INFO - mozversion application_remotingname: firefox 03:16:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:16:37 INFO - mozversion application_vendor: Mozilla 03:16:37 INFO - mozversion application_version: 55.0a1 03:16:37 INFO - mozversion platform_buildid: 20170503011221 03:16:37 INFO - mozversion platform_changeset: 82c2d17e74ef9cdf38a5d5ac4eb3ae846ec30ba4 03:16:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:16:37 INFO - mozversion platform_version: 55.0a1 03:16:37 INFO - using testdate: 1493806597 03:16:37 INFO - actual date: 1493806597 03:16:37 INFO - starting webserver on 'localhost:49234' 03:16:37 INFO - SUITE-START | Running 2 tests 03:16:37 INFO - TEST-START | dromaeo_css 03:16:37 INFO - operating with platform_type : mac_ 03:16:37 INFO - Initialising browser for dromaeo_css test... 03:16:37 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpEQI32G/profile http://localhost:49234/getInfo.html) 03:16:40 INFO - PID 1631 | 2017-05-03 03:16:40.098 plugin-container[1633:7473] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x973f, name = 'com.apple.tsm.portname' 03:16:40 INFO - PID 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:16:40 INFO - PID 1631 | 2017-05-03 03:16:40.100 plugin-container[1633:7473] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c1f, name = 'com.apple.CFPasteboardClient' 03:16:40 INFO - PID 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:16:40 INFO - PID 1631 | 2017-05-03 03:16:40.100 plugin-container[1633:7473] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:16:40 INFO - PID 1631 | __metrics Screen width/height:1600/1200 03:16:40 INFO - PID 1631 | colorDepth:24 03:16:40 INFO - PID 1631 | Browser inner width/height: 1024/691 03:16:40 INFO - PID 1631 | __metrics 03:16:41 INFO - TEST-INFO | 1631: exit 0 03:16:41 INFO - Browser initialized. 03:16:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:41 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpEQI32G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:43 INFO - PID 1634 | 2017-05-03 03:16:43.544 plugin-container[1635:7605] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 03:16:43 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:16:43 INFO - PID 1634 | 2017-05-03 03:16:43.545 plugin-container[1635:7605] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 03:16:43 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:16:43 INFO - PID 1634 | 2017-05-03 03:16:43.545 plugin-container[1635:7605] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:16:53 INFO - PID 1634 | RSS: Main: 234823680 03:16:53 INFO - PID 1634 | 03:19:56 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49234/tests/dromaeo/cssquery-ext.html) 03:19:58 INFO - PID 1634 | RSS: Main: 251633664 03:19:58 INFO - PID 1634 | 03:23:00 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-ext.html (next: http://localhost:49234/tests/dromaeo/cssquery-jquery.html) 03:23:00 INFO - PID 1634 | RSS: Main: 257703936 03:23:00 INFO - PID 1634 | 03:26:02 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49234/tests/dromaeo/cssquery-mootools.html) 03:26:03 INFO - PID 1634 | RSS: Main: 267612160 03:26:03 INFO - PID 1634 | 03:29:05 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49234/tests/dromaeo/cssquery-prototype.html) 03:29:05 INFO - PID 1634 | RSS: Main: 260366336 03:29:05 INFO - PID 1634 | 03:32:08 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49234/tests/dromaeo/cssquery-yui.html) 03:32:09 INFO - PID 1634 | RSS: Main: 263946240 03:32:09 INFO - PID 1634 | 03:35:10 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-yui.html (next: http://localhost:49234/tests/dromaeo/cssquery-dojo.html) 03:35:11 INFO - PID 1634 | RSS: Main: 262635520 03:35:11 INFO - PID 1634 | 03:35:11 INFO - PID 1634 | __start_tp_report 03:35:11 INFO - PID 1634 | _x_x_mozilla_page_load 03:35:11 INFO - PID 1634 | _x_x_mozilla_page_load_details 03:35:11 INFO - PID 1634 | |i|pagename|runs| 03:35:11 INFO - PID 1634 | |0;dojo.html;3375.628680845108;3573.10672331917;3578.8747393841204;3626.9455958160625;3636.072801435635;5772.422757724225;5962.701864906749;6116.510679145669;6170.444659980601;6230.532710046742;6131.407250743225;6141.72362243699;6170.876582468359;6184.381561843813;6193.287771906232;5405.243265942771;5433.646812957145;5461.317335333083;5495.148252020923;5588.30146231721;5053.140966035783;5424.05079111154;5461.74379892623;5586.692731899744;5613.747381367828;4979.377577802775;4995.875927916226;5550.389457159709;5554.055810512203;5584.91622625661;5189.455107213764;5417.756200970965;5488.067028605146;5565.276514053187;5606.971965140189;4874.756262186912;5429.484199001088;5450.100733378988;5468.125099983983;5473.17902314652;4949.678270912379;5772.884542309131;6259.655718935457;6265.122882796412;6274.843128921813;6462.289148193695;6555.475561955032;6606.537542372036;6736.730530778763;6745.123133992599;6759.2226893906845;6771.8984215236815;6812.216595091579;6817.488688348394;6836.145481814773;6241.21984751906;6315.210598675166;6315.336889626569;6317.336679648617;6317.3366796486625;6735.663216839139;6829.419499342612;6886.69009894556;6978.47661425385;6989.47578931572;6041.154238406627;6358;6424.582402143846;6485.643289619116;6609.339066093352;6690.632015239208;6755.1556055493065;6759.087523184406;6770.221424536143;6778.356056174655;6561.0814485972005;6677.799666010027;6697.665116744143;6707.564008339442;6710.798676039727;6428.325025872309;6543.5419520633095;6704.128463299739;6718.66406679664;6728.6635668216395;5294.470552944675;5299.284596579412;5314.388845282765;5353.304070470892;5357.8392648220615;4539.0694907543875;4704.012157446906;4707.905841883143;4730.030343779517;4752.738599377068;5155.432902380735;6197.4732147767945;6376.426121649074;6383.425491705769;6398.520110991694;6561.737530498726;6699.330066993261;6772.627505487147;6775.1531058617675;6796.626185559743;5350.652207606493;6299.086632438362;6369.968150159312;6378.553501254961;6381.425671689571;5968.612040217372;5973.253343332083;6006.519478441714;6020.367861374492;6047.485963693135;5742.827715168552;6748.122744043243;6845.555038922654;6956.060931774348;6986.790396288119;6812.795616131524;6831.419329357061;6843.589384636938;6849.212340580698;6883.965580172067;6998.16022077354;7007.273017902667;7007.859842803217;7034.979927910322;7040.683169257498;5519.365272993497;6431.646259455588;6557.180352455943;6723.562968407038;6727.629980351127;6792.083068785848;6858.794236172923;6861.691223894837;6866.725330986905;6870.931290687029;6266.749330026748;6431.389018043278;6575.473962083118;6622.072909792537;6628.668566571556;5450.209719590716;6461.838454038687;6484.675766211576;6595.208574971034;6623.966880165568;6299.11812346281;6410.134631824644;6505.934940650533;6517.9348206517325;6551.6069035858;6454.806355809334;6520.478361730955;6526.738930442919;6591.373819487141;6591.538592298685;6489.448396886318;6503.25212600557;6507.707153178024;6508.414242718178;6515.478761698958 03:35:11 INFO - PID 1634 | |1;ext.html;759.7986533568605;797.4378063465258;814.2305521282389;1195.7668254690334;1262.614902454751;36856.81571592142;37331.813340933324;37461.625383746155;37475;37542;37638.623613763855;38033.85898423045;38104.42843357345;38184.65414841918;38309.61690383095;7724.266194711493;7840.803979900519;8205.138460461656;8252.587370631474;8373.371997100212;8294;8396.11840756721;8400.117987611304;8401.075881653012;8409.411341206118;8338.916610833905;8373.790655233606;8416.452930559524;8440.240378365947;8452.873206901872;8369.995600527976;8375.20435558621;8395.916040839575;8400.705975290835;8402.453840500348;8223.54770487623;8225.218604232588;8280.668773249123;8282.716178992267;8301.543415112166;36174.63825361739;36609.084772880626;36668.81665591655;36755;36787.264254715024;3691.9261614767825;3696.741228114033;3738.0841693784923;3738.2523495300775;3741.8316175771884;29816;30346.393072138435;30401.391972160432;30437.695623043706;30453.543196852064;3135.7804953653254;3165.6042994625673;3170.5719727836677;3178.507331363642;3187;236321;239217;269769.999999998;281870;284650;46394.5360546397;46759.53240467552;46826;46880.53119468762;47092.05815883663;47399.28901066487;47970.80072998203;48152.75923620429;48244.758776206596;48279.75860120677;13697.520586779416;13741.450341986409;13903.4438622456;13922;13931.442742290195;11149;11277.492512836941;11355.602553910574;11390.430478476042;11422.25755325901;10778.784424311627;11158.944205278922;12999.1550549214;13118.540851070167;13140.211587304791;5656.264685590847;5754;5862.296524417097;5878.118282257696;5883.617349922764;1041.354360296621;1049.1606714628267;1049.3598904668147;1078.1805827571102;1088.9401082940356;21847.781522184894;23412.882935585214;24586;24621.38446538815;24879.75601219932;1144.7481554058095;1149.115181310403;1181.6159748081907;1191.9821202681967;1196.1029228078942;12321.691957701129;12471.93764031174;12513.562025329069;12544.059195560369;12585.622431327074;303094;304325;306353;306428;306559;52333.7383313081;52338;52581;52661.946761064566;52746.73626631919;1487.9956029679922;1508.9924550377177;1551.387202055182;1558.4467514032583;1563.366836431247;23875.283741487783;24001.519969600162;24046.87976560106;24065.75934240705;24105.91523381417;37342;37409.81295093507;37475.81262093672;37535.249295013404;37538.436923446716;274059;277074;277378.83931741444;277797;278328;32694;33001.50497742584;33042.66957330396;33261.50538709558;33370.83314583411;41752.37371439492;43661.56338436575;43696.34455483107;43704;43735.78132109319;28974.855125724236;29446.705532944397;29651.85174074116;30664.540031899094;30757.538636920017;24051;29953.85023074958;30091.69908300889;30284.09147725572;30450.238744031576;35401.114972125906;35416;36226.91319260426;36248.09379765527;36678.63321366752;30394.392112158075;30616;30774.38451230918;30779.230519237197;31312.373752524367;22590.531615444943;24359.634605481286;24409.26772196837;24664.260072197863;24752.50494990126 03:35:11 INFO - PID 1634 | |2;jquery.html;410.37827691048057;430.08821298846414;433.694273821365;438.3315443947979;458.67663297375356;19550.90224548879;21066.578668426624;21567.784322156775;21825.781742182575;21929.342119736393;21569;22065.227717029906;22473.32580022598;22616.321510354715;23341.533169336602;6107.999999999989;6234.283057448383;6276.905846412307;6289.056641503766;6296.779612713556;5906.527477801787;6158.107074474198;6208.6585237811905;6213.068039794044;6220.906686399685;6125.326214116466;6126.203593532835;6145.600535965148;6178.814635560918;6183.690815459231;5689.118186681071;5766.798162064329;6080.847978800543;6170.537209709245;6205.7517699291975;5322.2548843161985;5497.147942068986;5508.531774799147;5526.419725928759;5566.582506312002;20630;26684.33289167767;27348.58977115345;27875;28246.71753282482;2230.565039817236;2306.0084163809556;2308.180595888469;2310.191432998454;2316.8030717389042;16964.745528816955;17161.828381716146;17361.47915562535;17516;17659.11704414774;1884.594812115388;2141.689455029012;2142.2395049757424;2176.8040876321047;2178.7930146636045;150039.24980375028;154956.22521887432;158280.41719582773;159405;159905;11016.394098324668;11177.217594768288;12572.748545029232;12680.492780288869;12764.489420423079;15975.60060998461;16247.675046499004;16255.59361015984;16328.510144695678;16363.181840907908;7318.268173182639;7461.925380746232;8759.912400876037;8992;9142.085791420805;7283.3809126223805;8503.107173746792;8525;8725.476471411735;8732.777411162442;7019.684114214872;7274.709011639581;7691.115521714963;7697.230276972258;7729.536227826348;2171.6742488626833;2181.1166477576608;2186.7047948527065;2188.9014994325294;2296.724393072842;956.383132879289;957.9808403831885;965.9468729219819;1027.6865556005341;1032.0711359776262;20012.600268872007;20905.790942090385;21146.83692396933;21214.36356909295;21321.78678213198;898.9730308090768;948.2461443152572;987.8863930648067;1023.9537376305432;1043.186314674555;8086.272235498834;9814.558344874498;9961.800763984824;10661.893381066246;10772.622958196425;532760;539219;564353;570993;571201;129607.05589416166;131662;132110;133704;137874.31062844623;1206.3968015992004;1247.6257122863105;1262.141743614351;1267.8034904589804;1272.7072773262203;20426.89786551117;21604.35186944394;21610.675839862728;21610.91945402755;21692.674609881182;55834.44165558292;56082;56542.15186772119;56751.31116477416;57369.42630573641;76823;77559.83660244988;78097.60951195208;78644.60677696575;79062;8581.699640512801;8754.824903502022;8849.380543361904;8870.822583548423;8987.831581894574;13195.472181112647;13561.915046796035;13575.913926885627;13704.794428083387;13869.09850859691;9320.627174912928;11687.824682629938;11820.586279480176;11947.088465845423;12107.455164517794;10829.187810914056;10932;10936.726581835517;11064.446777661246;11158.49786759614;9524.95237523808;11587.304761714324;11986.220895642104;12091.395430228278;12102.576409825966;7198.20819709821;7684.46208765381;8758.080401558;8791.252743516618;8933.240674542476;11176.552937882394;11934.985526230368;12149.210301330386;12159.574414895436;12215.328156951453 03:35:11 INFO - PID 1634 | |3;mootools.html;1182.6984119049641;1197.3175290084655;1362.8841548468379;1428.8928330375225;1446.8697817196464;11009;11373.829392559108;11477.13921455891;11516.581517881255;11714.941425292884;11505.654830355083;11515.136364772634;11668.299902005885;11680.824787628171;11689.473973671184;2143.807057364837;2507.5611767940627;2535.1887396033185;2557.552428325045;2557.836184536041;1869.775626924771;2487.564676181661;2512.811539134563;2536.1757428835704;2539.669842920427;2491.314888405685;2508.3227528567277;2528.7091984421845;2535.6069809179517;2536.074332868508;2397.137030668958;2421.4914867877765;2440.1825388494876;2463.5319289335057;2485.9129930452436;2405.7113146422366;2484.6148846928754;2486.3038349262238;2517.1064272183294;2520.117958714454;11505;11588.01501872342;11670.358130302915;11690.47392867323;11700.239484433485;6586.538942274043;6755.22314933779;6840;6847.623380714059;6857.657117144173;4089.488813898263;4408.823647054114;4442.8667139985855;4450.933236001462;4466;1248.9937550312281;1262.6022802817083;1318.0378323823566;1324.1790090144173;1328.2628141381529;16283.941543799734;16612.83387166137;16705.749413758804;16825.83174168255;16834.49496515094;5557.3331200256225;5644.5484361251;5665.178549110356;5806.796762113306;5813;11752.647420577396;11826.290422574673;11858.822117668242;11866.228695134789;11884.989775869148;6519.674016299261;6571.57284776488;6579.506537009744;6583.80248592543;6587.604743715392;6040.486558642477;6077.665728384893;6120.846978825565;6224.253089629183;6230.314665386803;4316.223079845658;4421.336799480104;4448.5773851484055;4451.310046942729;4482.484514280834;1069.657709532942;1262.450833887262;1281.814136950137;1299.2789002103923;1306.764782339188;776.7514395393533;799.7923136064468;810.0643756461296;814.7881550796835;832.4006715165071;5529.336479622471;6185.536084793658;6207.820514102306;6382.627735036989;6507.739690412331;577.8150991682705;587.5769445998959;599.5653151465153;609.9146119543268;610.3774150366601;4268.573142685768;4325.935110973338;4384.7369157850635;4403.405540252089;4426.933595996063;14124.293785310694;14798.852011479963;14804.259787010822;14811.925940370229;14814.185219813015;14372.85627143736;14775.335109919864;14924.92537537327;14950.252487375805;14960.551183464513;7459.888101678479;8489.490630562186;8588.368210040073;8685.652573896974;8691.304695624334;5942.257217847769;6432.807015789534;6920;7076.823079423056;7093.929060709327;12961.351932403531;13135.605931822061;13145.145565538209;13465.326733663082;13512.864871351161;11041.06150977176;12477.563285284972;13228.40472178735;13524.256165910576;13639.659008524866;9274.165325120772;9327.300452465957;9379.249660027044;9382.96787353377;9435.952820235854;10358.326708763907;10588.311759735592;10690.572377104829;10698.946505267424;10726.195535334726;8975.596098175729;9007.414518056305;9209.493477858514;9264.11990860867;9359.06409359086;8766.123387661439;8943.284537237136;8982.461052336881;9007.864882026906;9015.594298256725;8167.959160204161;8172.918270817216;8196.016478022675;8201;8313.584320784057;6009.038553831366;6116.449519543263;6139.3553676863285;6168;6240.344763799736;6014.699265036643;6069.666168360606;6141.447269745566;6195.81412557624;6378.362163783585 03:35:11 INFO - PID 1634 | |4;prototype.html;332.2159703100682;403.4271334704719;408.64652075954297;408.7465771221843;411.48153326808193;5562.916556251655;6163.753449862012;6196.31840497546;6266.965950618148;6353.618782873025;6127.938720612792;6279.9904030710195;6373.267074286458;6377.649229292387;6382.361763823627;4815.614750819944;4839.153148199069;4840.9273860891935;4845.127876982142;4864.902701945959;4727.950471945593;4779.474257831635;4827.493113223114;4854.56308932196;4864.829730959417;3920.764754114748;4178.477690288714;4493.281075027996;4791.448983366922;4791.928121078169;4785.617150627942;4823.5176482351835;4834.323194752737;4850.466448690641;4852.344933434012;4123.773192474413;4222.619964203206;4256.297710877701;4279;4293.012607100353;5077.64456488046;5156.097682905476;5286.920696189561;5897.469227769521;6232.470240029603;4509.7970591323465;5259.842204733826;5534.916976245359;5720.856978575527;5736.770529178828;6747.359000894956;6820.420264277493;6832.642738255294;6855.314468553154;6857.828554286133;4079.673626109904;4081.571434999312;4291.914161716748;4855.927161092586;4868.829590964299;6541.149650545399;7023.227444981099;7096.077509923729;7173.6413179340825;7196.784096477114;4520;4900.975495122501;4950.3069570260195;4954.925676114861;4979.352684151109;4006.659433948147;4312.762798046075;5074.492550744896;5075.441701412841;5076.416212135578;5531.096174508335;5574.58190635704;5652.406497317805;5706.28671416073;5730.942690573041;5831.79588714393;5960.970195149083;6880.415164710956;6883.621400822903;6906.412954898789;1430.4564265579222;1576.2670358283453;1606.5903194685282;1715.2452920715095;1736.5311365931127;1161.9593314233962;1177.5760726138583;1184.2302503372875;1186.6143503361443;1191.5531675621642;6451.548391612542;6456.903146452807;6458.1906870511475;6463.572452869799;6538.8365290868105;6834.692438840264;6907.930920690829;6984.755533556403;7023.297670233038;7036.296370363025;6389.936100639027;6409.327020662857;6459.806205813833;6467.2562655294305;6476.838079048061;3032.529957856536;3248.3178532507964;3615.746897717187;3675.933979146018;3681.3557627415094;6098.695065246809;6408.878446271884;6984.476164287698;7040.190378106481;7256.96371518139;7080.964595176991;7199.496035277585;7207.675654595556;7255.709771609182;7259.237780033126;7355.852882942419;7398.926010739931;7413.184549699421;7429.322485369777;7431.628418578941;6890.621015843976;7124.358807707331;7126.786196414116;7129.394001509722;7129.857402851811;5779.36426993022;6407.7640791400045;7000.719971201095;7022.419955509969;7044.788656340318;6454;7032.437405007689;7284.817879553054;7391.1500177480275;7465.253474652492;4414.801333939916;4425.645948324062;4439.334099885043;4467.106578684341;4475.462944446687;7138.892916606152;7185.497015208885;7190.496665233383;7232.385247254042;7283.417326613964;5195.896082078413;6060.727247277945;6672.332766723289;6805.829854253683;6877;5429.6199266051;6809.965950170217;6839.658017099225;6867.931320686729;6887.586744795329;5551.361593416808;6545.607263564201;6703.826830304774;6706.631135287606;6748.932510675027;5101.260317253903;6442.35576442352;6774.627395493295;6883.965580172067;6915.446764258948;5620.819627878192;6492.64290464029;6562.671866406565;6682.331766823473;6694.665266736546 03:35:11 INFO - PID 1634 | |5;yui.html;750.6809605917484;845.281510715892;856.0412338181238;858.862581986882;879.7068309584907;16165.595860103489;16582.92211006284;16602.833971660293;18488.075596220202;19207.42377728667;17630.735538966925;17880.28478860844;18063.72904406435;18228.453146405594;18539.629207415877;972.4602845420789;990.9108180263775;992.831218692824;994.0457161125329;997.3866072365479;989.65362123257;1000.0299709281985;1000.564754331868;1001.2540657210352;1003.2225025605178;1058.5077938758475;1058.6453538064718;1058.6506452870535;1059.7350662334416;1060.8249638809586;1044.3264094658941;1052.5894900988621;1053.8682664666917;1054.7574057966672;1057.1384321777764;730.9853802923965;758.1963119093779;763.4922776353718;766.5898744171841;767.6161919040479;16430.424935127212;16579;16596.08721520316;16596.917015414965;16600.50198494047;17109.23008464622;17178.914105429518;17481.56296092608;17599.472015839547;17621.647567048716;11024.724381890437;13649.249291288976;13888.23614701191;13939.651508712263;13944.790828137586;3495.353359628477;3553.6446355364515;3555.7866528008403;3562.750607457479;3565.554305711786;128252;128675;129759;129967.45113921062;132467.33766331107;11936.641900742992;13206.537771177962;13274.867251327556;13594.728105438033;13608.115472494255;25114.246572602486;25187.36282141655;25326.746732532807;25363.619545706828;25605.359866003128;7681.5775132367135;7726.575038372831;7730.149683534807;7786.610669466504;7787.649555770004;3331.9666803332143;3996.540397854284;4007.5992400760274;4020.618041286073;4024.1348110156455;4295.656347492193;4347.695661303678;4384.495782984934;4390.165868484977;4393.648508119343;875.7504111328241;894.8702438146432;898.1736802142045;899.1143723432414;900.6757567275776;660.6663634864362;683.8461346197165;689.6034780001519;690.8963655451722;691.9757808476679;10240.48797560119;11171.72070698239;11775.454572686634;11900.226485278428;11940.820887686692;658.8682263547214;660.8050625065617;675.8107729835654;682.4199430484148;699.5872435263118;4411.1618792429335;5290.92063619046;5378.273933019071;5504.366997795225;5505.532029777433;84492;101952;110748.78502429907;111074;114218;97702.02297977071;98432;99909.50045249728;101150.48274275892;102012;85963.14036859677;86603.74151360283;86607.56696216478;86684.56657716798;87523.68714469289;10819.242653014213;10939.50772215268;11047.337159770439;11097.446357509794;11356.54573817038;43612.78193609012;43684.78157609192;44090.55909440993;44800.77599612111;44884.87787805331;56071.719641403164;56666.7166664164;56957.715211423674;57301.14048289362;57691.423085770286;13688;13897.374618142007;14067.788983165055;14154.858451415354;14174.433022678977;15178.316975735897;15318.693626127191;15439.768403473732;15532.456364027204;15546.455874044354;13864.376103075185;13877.791833122714;14174.574762757135;14406.711865762836;14411.207383593584;14081.859181408465;14103.435862565382;14203.573892783234;14259.429622815385;14342.85657143457;13075.084744067824;13159.407826647632;13464.932675336953;13529;13568.796468053184;9140.771480712769;9926.106650401498;9986.151177149733;10344.37933723979;10722.356658600509;9992.600295988079;10494.160467162761;11366.829497557708;11562.248453850472;12778.808317875053 03:35:11 INFO - PID 1634 | __end_tp_report 03:35:11 INFO - PID 1634 | __start_cc_report 03:35:11 INFO - PID 1634 | _x_x_mozilla_cycle_collect,414 03:35:11 INFO - PID 1634 | __end_cc_report 03:35:11 INFO - PID 1634 | __startTimestamp1493807710999__endTimestamp 03:35:11 INFO - PID 1634 | 03:35:11 INFO - PID 1634 | ------- Summary: start ------- 03:35:11 INFO - PID 1634 | Number of tests: 6 03:35:11 INFO - PID 1634 | 03:35:11 INFO - PID 1634 | [#0] dojo.html Cycles:165 Average:6146.16 Median:6410.13 stddev:762.28 (11.9%) stddev-sans-first:732.97 03:35:11 INFO - PID 1634 | Values: 3375.6 3573.1 3578.9 3626.9 3636.1 5772.4 5962.7 6116.5 6170.4 6230.5 6131.4 6141.7 6170.9 6184.4 6193.3 5405.2 5433.6 5461.3 5495.1 5588.3 5053.1 5424.1 5461.7 5586.7 5613.7 4979.4 4995.9 5550.4 5554.1 5584.9 5189.5 5417.8 5488.1 5565.3 5607.0 4874.8 5429.5 5450.1 5468.1 5473.2 4949.7 5772.9 6259.7 6265.1 6274.8 6462.3 6555.5 6606.5 6736.7 6745.1 6759.2 6771.9 6812.2 6817.5 6836.1 6241.2 6315.2 6315.3 6317.3 6317.3 6735.7 6829.4 6886.7 6978.5 6989.5 6041.2 6358.0 6424.6 6485.6 6609.3 6690.6 6755.2 6759.1 6770.2 6778.4 6561.1 6677.8 6697.7 6707.6 6710.8 6428.3 6543.5 6704.1 6718.7 6728.7 5294.5 5299.3 5314.4 5353.3 5357.8 4539.1 4704.0 4707.9 4730.0 4752.7 5155.4 6197.5 6376.4 6383.4 6398.5 6561.7 6699.3 6772.6 6775.2 6796.6 5350.7 6299.1 6370.0 6378.6 6381.4 5968.6 5973.3 6006.5 6020.4 6047.5 5742.8 6748.1 6845.6 6956.1 6986.8 6812.8 6831.4 6843.6 6849.2 6884.0 6998.2 7007.3 7007.9 7035.0 7040.7 5519.4 6431.6 6557.2 6723.6 6727.6 6792.1 6858.8 6861.7 6866.7 6870.9 6266.7 6431.4 6575.5 6622.1 6628.7 5450.2 6461.8 6484.7 6595.2 6624.0 6299.1 6410.1 6505.9 6517.9 6551.6 6454.8 6520.5 6526.7 6591.4 6591.5 6489.4 6503.3 6507.7 6508.4 6515.5 03:35:11 INFO - PID 1634 | 03:35:11 INFO - PID 1634 | [#1] ext.html Cycles:180 Average:43183.54 Median:3182.75 stddev:73905.50 (2322.1%) stddev-sans-first:74044.18 03:35:11 INFO - PID 1634 | Values: 759.8 797.4 814.2 1195.8 1262.6 36856.8 37331.8 37461.6 37475.0 37542.0 37638.6 38033.9 38104.4 38184.7 38309.6 7724.3 7840.8 8205.1 8252.6 8373.4 8294.0 8396.1 8400.1 8401.1 8409.4 8338.9 8373.8 8416.5 8440.2 8452.9 8370.0 8375.2 8395.9 8400.7 8402.5 8223.5 8225.2 8280.7 8282.7 8301.5 36174.6 36609.1 36668.8 36755.0 36787.3 3691.9 3696.7 3738.1 3738.3 3741.8 29816.0 30346.4 30401.4 30437.7 30453.5 3135.8 3165.6 3170.6 3178.5 3187.0 236321.0 239217.0 269770.0 281870.0 284650.0 46394.5 46759.5 46826.0 46880.5 47092.1 47399.3 47970.8 48152.8 48244.8 48279.8 13697.5 13741.5 13903.4 13922.0 13931.4 11149.0 11277.5 11355.6 11390.4 11422.3 10778.8 11158.9 12999.2 13118.5 13140.2 5656.3 5754.0 5862.3 5878.1 5883.6 1041.4 1049.2 1049.4 1078.2 1088.9 21847.8 23412.9 24586.0 24621.4 24879.8 1144.7 1149.1 1181.6 1192.0 1196.1 12321.7 12471.9 12513.6 12544.1 12585.6 303094.0 304325.0 306353.0 306428.0 306559.0 52333.7 52338.0 52581.0 52661.9 52746.7 1488.0 1509.0 1551.4 1558.4 1563.4 23875.3 24001.5 24046.9 24065.8 24105.9 37342.0 37409.8 37475.8 37535.2 37538.4 274059.0 277074.0 277378.8 277797.0 278328.0 32694.0 33001.5 33042.7 33261.5 33370.8 41752.4 43661.6 43696.3 43704.0 43735.8 28974.9 29446.7 29651.9 30664.5 30757.5 24051.0 29953.9 30091.7 30284.1 30450.2 35401.1 35416.0 36226.9 36248.1 36678.6 30394.4 30616.0 30774.4 30779.2 31312.4 22590.5 24359.6 24409.3 24664.3 24752.5 03:35:11 INFO - PID 1634 | 03:35:11 INFO - PID 1634 | [#2] jquery.html Cycles:180 Average:35781.77 Median:2307.09 stddev:94407.24 (4092.0%) stddev-sans-first:94634.72 03:35:11 INFO - PID 1634 | Values: 410.4 430.1 433.7 438.3 458.7 19550.9 21066.6 21567.8 21825.8 21929.3 21569.0 22065.2 22473.3 22616.3 23341.5 6108.0 6234.3 6276.9 6289.1 6296.8 5906.5 6158.1 6208.7 6213.1 6220.9 6125.3 6126.2 6145.6 6178.8 6183.7 5689.1 5766.8 6080.8 6170.5 6205.8 5322.3 5497.1 5508.5 5526.4 5566.6 20630.0 26684.3 27348.6 27875.0 28246.7 2230.6 2306.0 2308.2 2310.2 2316.8 16964.7 17161.8 17361.5 17516.0 17659.1 1884.6 2141.7 2142.2 2176.8 2178.8 150039.2 154956.2 158280.4 159405.0 159905.0 11016.4 11177.2 12572.7 12680.5 12764.5 15975.6 16247.7 16255.6 16328.5 16363.2 7318.3 7461.9 8759.9 8992.0 9142.1 7283.4 8503.1 8525.0 8725.5 8732.8 7019.7 7274.7 7691.1 7697.2 7729.5 2171.7 2181.1 2186.7 2188.9 2296.7 956.4 958.0 965.9 1027.7 1032.1 20012.6 20905.8 21146.8 21214.4 21321.8 899.0 948.2 987.9 1024.0 1043.2 8086.3 9814.6 9961.8 10661.9 10772.6 532760.0 539219.0 564353.0 570993.0 571201.0 129607.1 131662.0 132110.0 133704.0 137874.3 1206.4 1247.6 1262.1 1267.8 1272.7 20426.9 21604.4 21610.7 21610.9 21692.7 55834.4 56082.0 56542.2 56751.3 57369.4 76823.0 77559.8 78097.6 78644.6 79062.0 8581.7 8754.8 8849.4 8870.8 8987.8 13195.5 13561.9 13575.9 13704.8 13869.1 9320.6 11687.8 11820.6 11947.1 12107.5 10829.2 10932.0 10936.7 11064.4 11158.5 9525.0 11587.3 11986.2 12091.4 12102.6 7198.2 7684.5 8758.1 8791.3 8933.2 11176.6 11935.0 12149.2 12159.6 12215.3 03:35:11 INFO - PID 1634 | 03:35:11 INFO - PID 1634 | [#3] mootools.html Cycles:180 Average:7065.80 Median:4179.03 stddev:4449.98 (106.5%) stddev-sans-first:4440.50 03:35:11 INFO - PID 1634 | Values: 1182.7 1197.3 1362.9 1428.9 1446.9 11009.0 11373.8 11477.1 11516.6 11714.9 11505.7 11515.1 11668.3 11680.8 11689.5 2143.8 2507.6 2535.2 2557.6 2557.8 1869.8 2487.6 2512.8 2536.2 2539.7 2491.3 2508.3 2528.7 2535.6 2536.1 2397.1 2421.5 2440.2 2463.5 2485.9 2405.7 2484.6 2486.3 2517.1 2520.1 11505.0 11588.0 11670.4 11690.5 11700.2 6586.5 6755.2 6840.0 6847.6 6857.7 4089.5 4408.8 4442.9 4450.9 4466.0 1249.0 1262.6 1318.0 1324.2 1328.3 16283.9 16612.8 16705.7 16825.8 16834.5 5557.3 5644.5 5665.2 5806.8 5813.0 11752.6 11826.3 11858.8 11866.2 11885.0 6519.7 6571.6 6579.5 6583.8 6587.6 6040.5 6077.7 6120.8 6224.3 6230.3 4316.2 4421.3 4448.6 4451.3 4482.5 1069.7 1262.5 1281.8 1299.3 1306.8 776.8 799.8 810.1 814.8 832.4 5529.3 6185.5 6207.8 6382.6 6507.7 577.8 587.6 599.6 609.9 610.4 4268.6 4325.9 4384.7 4403.4 4426.9 14124.3 14798.9 14804.3 14811.9 14814.2 14372.9 14775.3 14924.9 14950.3 14960.6 7459.9 8489.5 8588.4 8685.7 8691.3 5942.3 6432.8 6920.0 7076.8 7093.9 12961.4 13135.6 13145.1 13465.3 13512.9 11041.1 12477.6 13228.4 13524.3 13639.7 9274.2 9327.3 9379.2 9383.0 9436.0 10358.3 10588.3 10690.6 10698.9 10726.2 8975.6 9007.4 9209.5 9264.1 9359.1 8766.1 8943.3 8982.5 9007.9 9015.6 8168.0 8172.9 8196.0 8201.0 8313.6 6009.0 6116.4 6139.4 6168.0 6240.3 6014.7 6069.7 6141.4 6195.8 6378.4 03:35:11 INFO - PID 1634 | 03:35:11 INFO - PID 1634 | [#4] prototype.html Cycles:180 Average:5527.02 Median:6145.85 stddev:1727.52 (28.1%) stddev-sans-first:1687.79 03:35:11 INFO - PID 1634 | Values: 332.2 403.4 408.6 408.7 411.5 5562.9 6163.8 6196.3 6267.0 6353.6 6127.9 6280.0 6373.3 6377.6 6382.4 4815.6 4839.2 4840.9 4845.1 4864.9 4728.0 4779.5 4827.5 4854.6 4864.8 3920.8 4178.5 4493.3 4791.4 4791.9 4785.6 4823.5 4834.3 4850.5 4852.3 4123.8 4222.6 4256.3 4279.0 4293.0 5077.6 5156.1 5286.9 5897.5 6232.5 4509.8 5259.8 5534.9 5720.9 5736.8 6747.4 6820.4 6832.6 6855.3 6857.8 4079.7 4081.6 4291.9 4855.9 4868.8 6541.1 7023.2 7096.1 7173.6 7196.8 4520.0 4901.0 4950.3 4954.9 4979.4 4006.7 4312.8 5074.5 5075.4 5076.4 5531.1 5574.6 5652.4 5706.3 5730.9 5831.8 5961.0 6880.4 6883.6 6906.4 1430.5 1576.3 1606.6 1715.2 1736.5 1162.0 1177.6 1184.2 1186.6 1191.6 6451.5 6456.9 6458.2 6463.6 6538.8 6834.7 6907.9 6984.8 7023.3 7036.3 6389.9 6409.3 6459.8 6467.3 6476.8 3032.5 3248.3 3615.7 3675.9 3681.4 6098.7 6408.9 6984.5 7040.2 7257.0 7081.0 7199.5 7207.7 7255.7 7259.2 7355.9 7398.9 7413.2 7429.3 7431.6 6890.6 7124.4 7126.8 7129.4 7129.9 5779.4 6407.8 7000.7 7022.4 7044.8 6454.0 7032.4 7284.8 7391.2 7465.3 4414.8 4425.6 4439.3 4467.1 4475.5 7138.9 7185.5 7190.5 7232.4 7283.4 5195.9 6060.7 6672.3 6805.8 6877.0 5429.6 6810.0 6839.7 6867.9 6887.6 5551.4 6545.6 6703.8 6706.6 6748.9 5101.3 6442.4 6774.6 6884.0 6915.4 5620.8 6492.6 6562.7 6682.3 6694.7 03:35:11 INFO - PID 1634 | 03:35:11 INFO - PID 1634 | [#5] yui.html Cycles:180 Average:21963.33 Median:17972.01 stddev:32167.25 (179.0%) stddev-sans-first:32218.05 03:35:11 INFO - PID 1634 | Values: 750.7 845.3 856.0 858.9 879.7 16165.6 16582.9 16602.8 18488.1 19207.4 17630.7 17880.3 18063.7 18228.5 18539.6 972.5 990.9 992.8 994.0 997.4 989.7 1000.0 1000.6 1001.3 1003.2 1058.5 1058.6 1058.7 1059.7 1060.8 1044.3 1052.6 1053.9 1054.8 1057.1 731.0 758.2 763.5 766.6 767.6 16430.4 16579.0 16596.1 16596.9 16600.5 17109.2 17178.9 17481.6 17599.5 17621.6 11024.7 13649.2 13888.2 13939.7 13944.8 3495.4 3553.6 3555.8 3562.8 3565.6 128252.0 128675.0 129759.0 129967.5 132467.3 11936.6 13206.5 13274.9 13594.7 13608.1 25114.2 25187.4 25326.7 25363.6 25605.4 7681.6 7726.6 7730.1 7786.6 7787.6 3332.0 3996.5 4007.6 4020.6 4024.1 4295.7 4347.7 4384.5 4390.2 4393.6 875.8 894.9 898.2 899.1 900.7 660.7 683.8 689.6 690.9 692.0 10240.5 11171.7 11775.5 11900.2 11940.8 658.9 660.8 675.8 682.4 699.6 4411.2 5290.9 5378.3 5504.4 5505.5 84492.0 101952.0 110748.8 111074.0 114218.0 97702.0 98432.0 99909.5 101150.5 102012.0 85963.1 86603.7 86607.6 86684.6 87523.7 10819.2 10939.5 11047.3 11097.4 11356.5 43612.8 43684.8 44090.6 44800.8 44884.9 56071.7 56666.7 56957.7 57301.1 57691.4 13688.0 13897.4 14067.8 14154.9 14174.4 15178.3 15318.7 15439.8 15532.5 15546.5 13864.4 13877.8 14174.6 14406.7 14411.2 14081.9 14103.4 14203.6 14259.4 14342.9 13075.1 13159.4 13464.9 13529.0 13568.8 9140.8 9926.1 9986.2 10344.4 10722.4 9992.6 10494.2 11366.8 11562.2 12778.8 03:35:11 INFO - PID 1634 | -------- Summary: end -------- 03:35:11 INFO - PID 1634 | 03:35:11 INFO - TEST-INFO | 1634: exit 0 03:35:11 INFO - TEST-OK | dromaeo_css | took 1114516ms 03:35:11 INFO - TEST-START | kraken 03:35:11 INFO - operating with platform_type : mac_ 03:35:11 INFO - Initialising browser for kraken test... 03:35:11 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpKBenCc/profile http://localhost:49234/getInfo.html) 03:35:14 INFO - PID 1672 | 2017-05-03 03:35:14.871 plugin-container[1673:10069] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 03:35:14 INFO - PID 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:35:14 INFO - PID 1672 | 2017-05-03 03:35:14.874 plugin-container[1673:10069] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 03:35:14 INFO - PID 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:35:14 INFO - PID 1672 | 2017-05-03 03:35:14.874 plugin-container[1673:10069] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:35:14 INFO - PID 1672 | __metrics Screen width/height:1600/1200 03:35:14 INFO - PID 1672 | colorDepth:24 03:35:14 INFO - PID 1672 | Browser inner width/height: 1024/691 03:35:14 INFO - PID 1672 | __metrics 03:35:15 INFO - TEST-INFO | 1672: exit 0 03:35:15 INFO - Browser initialized. 03:35:15 INFO - Running cycle 1/1 for kraken test... 03:35:15 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpKBenCc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:18 INFO - PID 1674 | 2017-05-03 03:35:18.158 plugin-container[1675:10197] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 03:35:18 INFO - PID 1674 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:35:18 INFO - PID 1674 | 2017-05-03 03:35:18.158 plugin-container[1675:10197] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470b, name = 'com.apple.CFPasteboardClient' 03:35:18 INFO - PID 1674 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:35:18 INFO - PID 1674 | 2017-05-03 03:35:18.158 plugin-container[1675:10197] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:35:28 INFO - PID 1674 | RSS: Main: 234500096 03:35:28 INFO - PID 1674 | 03:35:30 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection) 03:35:31 INFO - PID 1674 | RSS: Main: 247820288 03:35:31 INFO - PID 1674 | 03:35:34 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-dft) 03:35:34 INFO - PID 1674 | RSS: Main: 256282624 03:35:34 INFO - PID 1674 | 03:35:38 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-fft) 03:35:39 INFO - PID 1674 | RSS: Main: 258543616 03:35:39 INFO - PID 1674 | 03:35:40 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator) 03:35:41 INFO - PID 1674 | RSS: Main: 260812800 03:35:41 INFO - PID 1674 | 03:35:43 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:35:44 INFO - PID 1674 | RSS: Main: 261320704 03:35:44 INFO - PID 1674 | 03:35:47 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom) 03:35:47 INFO - PID 1674 | RSS: Main: 267231232 03:35:47 INFO - PID 1674 | 03:35:50 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate) 03:35:51 INFO - PID 1674 | RSS: Main: 269209600 03:35:51 INFO - PID 1674 | 03:35:54 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial) 03:35:54 INFO - PID 1674 | RSS: Main: 268333056 03:35:54 INFO - PID 1674 | 03:35:56 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:35:56 INFO - PID 1674 | RSS: Main: 267767808 03:35:56 INFO - PID 1674 | 03:35:58 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:35:59 INFO - PID 1674 | RSS: Main: 267698176 03:35:59 INFO - PID 1674 | 03:36:01 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:36:02 INFO - PID 1674 | RSS: Main: 267128832 03:36:02 INFO - PID 1674 | 03:36:05 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:05 INFO - PID 1674 | RSS: Main: 267157504 03:36:05 INFO - PID 1674 | 03:36:09 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:09 INFO - PID 1674 | RSS: Main: 267472896 03:36:09 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49234/tests/kraken/driver.html?testName=ai-astar) 03:36:11 INFO - PID 1674 | RSS: Main: 268939264 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | __start_tp_report 03:36:11 INFO - PID 1674 | _x_x_mozilla_page_load 03:36:11 INFO - PID 1674 | _x_x_mozilla_page_load_details 03:36:11 INFO - PID 1674 | |i|pagename|runs| 03:36:11 INFO - PID 1674 | |0;ai-astar;102;112;111;124;171;169;146;114;114;115 03:36:11 INFO - PID 1674 | |1;audio-beat-detection;135;104;110;147;110;111;110;111;141;146 03:36:11 INFO - PID 1674 | |2;audio-dft;198;203;203;206;214;231;237;264;288;204 03:36:11 INFO - PID 1674 | |3;audio-fft;82;60;61;86;63;62;57;61;76;58 03:36:11 INFO - PID 1674 | |4;audio-oscillator;89;69;85;92;101;101;87;71;77;90 03:36:11 INFO - PID 1674 | |5;imaging-gaussian-blur;89;90;90;98;90;89;89;93;113;90 03:36:11 INFO - PID 1674 | |6;imaging-darkroom;96;125;97;96;96;97;96;97;97;98 03:36:11 INFO - PID 1674 | |7;imaging-desaturate;91;93;91;91;90;90;90;94;92;94 03:36:11 INFO - PID 1674 | |8;json-parse-financial;55;52;53;52;55;54;51;52;52;52 03:36:11 INFO - PID 1674 | |9;json-stringify-tinderbox;59;67;57;65;92;50;54;68;85;82 03:36:11 INFO - PID 1674 | |10;stanford-crypto-aes;88;75;116;110;73;75;92;98;116;105 03:36:11 INFO - PID 1674 | |11;stanford-crypto-ccm;137;142;149;148;134;139;144;136;201;143 03:36:11 INFO - PID 1674 | |12;stanford-crypto-pbkdf2;188;225;166;227;232;191;181;188;174;180 03:36:11 INFO - PID 1674 | |13;stanford-crypto-sha256-iterative;70;71;68;70;68;70;67;88;85;71 03:36:11 INFO - PID 1674 | __end_tp_report 03:36:11 INFO - PID 1674 | __start_cc_report 03:36:11 INFO - PID 1674 | _x_x_mozilla_cycle_collect,984 03:36:11 INFO - PID 1674 | __end_cc_report 03:36:11 INFO - PID 1674 | __startTimestamp1493807771663__endTimestamp 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | ------- Summary: start ------- 03:36:11 INFO - PID 1674 | Number of tests: 14 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#0] ai-astar Cycles:10 Average:127.80 Median:119.50 stddev:25.06 (21.0%) stddev-sans-first:24.78 03:36:11 INFO - PID 1674 | Values: 102.0 112.0 111.0 124.0 171.0 169.0 146.0 114.0 114.0 115.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:123.00 stddev:17.41 (14.2%) stddev-sans-first:17.86 03:36:11 INFO - PID 1674 | Values: 135.0 104.0 110.0 147.0 110.0 111.0 110.0 111.0 141.0 146.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#2] audio-dft Cycles:10 Average:224.80 Median:222.50 stddev:30.35 (13.6%) stddev-sans-first:30.60 03:36:11 INFO - PID 1674 | Values: 198.0 203.0 203.0 206.0 214.0 231.0 237.0 264.0 288.0 204.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#3] audio-fft Cycles:10 Average:66.60 Median:62.50 stddev:10.59 (16.9%) stddev-sans-first:9.65 03:36:11 INFO - PID 1674 | Values: 82.0 60.0 61.0 86.0 63.0 62.0 57.0 61.0 76.0 58.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#4] audio-oscillator Cycles:10 Average:86.20 Median:86.00 stddev:11.09 (12.9%) stddev-sans-first:11.72 03:36:11 INFO - PID 1674 | Values: 89.0 69.0 85.0 92.0 101.0 101.0 87.0 71.0 77.0 90.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:90.00 stddev:7.52 (8.4%) stddev-sans-first:7.83 03:36:11 INFO - PID 1674 | Values: 89.0 90.0 90.0 98.0 90.0 89.0 89.0 93.0 113.0 90.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:97.00 stddev:8.98 (9.3%) stddev-sans-first:9.44 03:36:11 INFO - PID 1674 | Values: 96.0 125.0 97.0 96.0 96.0 97.0 96.0 97.0 97.0 98.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#7] imaging-desaturate Cycles:10 Average:91.60 Median:91.50 stddev:1.58 (1.7%) stddev-sans-first:1.66 03:36:11 INFO - PID 1674 | Values: 91.0 93.0 91.0 91.0 90.0 90.0 90.0 94.0 92.0 94.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:52.50 stddev:1.40 (2.7%) stddev-sans-first:1.24 03:36:11 INFO - PID 1674 | Values: 55.0 52.0 53.0 52.0 55.0 54.0 51.0 52.0 52.0 52.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:67.50 stddev:14.11 (20.9%) stddev-sans-first:14.60 03:36:11 INFO - PID 1674 | Values: 59.0 67.0 57.0 65.0 92.0 50.0 54.0 68.0 85.0 82.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#10] stanford-crypto-aes Cycles:10 Average:94.80 Median:75.00 stddev:16.86 (22.5%) stddev-sans-first:17.70 03:36:11 INFO - PID 1674 | Values: 88.0 75.0 116.0 110.0 73.0 75.0 92.0 98.0 116.0 105.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:143.50 stddev:19.51 (13.6%) stddev-sans-first:20.33 03:36:11 INFO - PID 1674 | Values: 137.0 142.0 149.0 148.0 134.0 139.0 144.0 136.0 201.0 143.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.20 Median:189.50 stddev:23.83 (12.6%) stddev-sans-first:25.13 03:36:11 INFO - PID 1674 | Values: 188.0 225.0 166.0 227.0 232.0 191.0 181.0 188.0 174.0 180.0 03:36:11 INFO - PID 1674 | 03:36:11 INFO - PID 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:70.50 stddev:7.38 (10.5%) stddev-sans-first:7.75 03:36:11 INFO - PID 1674 | Values: 70.0 71.0 68.0 70.0 68.0 70.0 67.0 88.0 85.0 71.0 03:36:11 INFO - PID 1674 | -------- Summary: end -------- 03:36:11 INFO - PID 1674 | 03:36:12 INFO - TEST-INFO | 1674: exit 0 03:36:12 INFO - TEST-OK | kraken | took 60906ms 03:36:12 INFO - SUITE-END | took 1175s 03:36:12 INFO - Completed test suite (00:19:35) 03:36:12 INFO - javascript benchmark 03:36:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7860.464440658514, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.628680845108, 3573.10672331917, 3578.8747393841204, 3626.9455958160625, 3636.072801435635, 5772.422757724225, 5962.701864906749, 6116.510679145669, 6170.444659980601, 6230.532710046742, 6131.407250743225, 6141.72362243699, 6170.876582468359, 6184.381561843813, 6193.287771906232, 5405.243265942771, 5433.646812957145, 5461.317335333083, 5495.148252020923, 5588.30146231721, 5053.140966035783, 5424.05079111154, 5461.74379892623, 5586.692731899744, 5613.747381367828, 4979.377577802775, 4995.875927916226, 5550.389457159709, 5554.055810512203, 5584.91622625661, 5189.455107213764, 5417.756200970965, 5488.067028605146, 5565.276514053187, 5606.971965140189, 4874.756262186912, 5429.484199001088, 5450.100733378988, 5468.125099983983, 5473.17902314652, 4949.678270912379, 5772.884542309131, 6259.655718935457, 6265.122882796412, 6274.843128921813, 6462.289148193695, 6555.475561955032, 6606.537542372036, 6736.730530778763, 6745.123133992599, 6759.2226893906845, 6771.8984215236815, 6812.216595091579, 6817.488688348394, 6836.145481814773, 6241.21984751906, 6315.210598675166, 6315.336889626569, 6317.336679648617, 6317.3366796486625, 6735.663216839139, 6829.419499342612, 6886.69009894556, 6978.47661425385, 6989.47578931572, 6041.154238406627, 6358.0, 6424.582402143846, 6485.643289619116, 6609.339066093352, 6690.632015239208, 6755.1556055493065, 6759.087523184406, 6770.221424536143, 6778.356056174655, 6561.0814485972005, 6677.799666010027, 6697.665116744143, 6707.564008339442, 6710.798676039727, 6428.325025872309, 6543.5419520633095, 6704.128463299739, 6718.66406679664, 6728.6635668216395, 5294.470552944675, 5299.284596579412, 5314.388845282765, 5353.304070470892, 5357.8392648220615, 4539.0694907543875, 4704.012157446906, 4707.905841883143, 4730.030343779517, 4752.738599377068, 5155.432902380735, 6197.4732147767945, 6376.426121649074, 6383.425491705769, 6398.520110991694, 6561.737530498726, 6699.330066993261, 6772.627505487147, 6775.1531058617675, 6796.626185559743, 5350.652207606493, 6299.086632438362, 6369.968150159312, 6378.553501254961, 6381.425671689571, 5968.612040217372, 5973.253343332083, 6006.519478441714, 6020.367861374492, 6047.485963693135, 5742.827715168552, 6748.122744043243, 6845.555038922654, 6956.060931774348, 6986.790396288119, 6812.795616131524, 6831.419329357061, 6843.589384636938, 6849.212340580698, 6883.965580172067, 6998.16022077354, 7007.273017902667, 7007.859842803217, 7034.979927910322, 7040.683169257498, 5519.365272993497, 6431.646259455588, 6557.180352455943, 6723.562968407038, 6727.629980351127, 6792.083068785848, 6858.794236172923, 6861.691223894837, 6866.725330986905, 6870.931290687029, 6266.749330026748, 6431.389018043278, 6575.473962083118, 6622.072909792537, 6628.668566571556, 5450.209719590716, 6461.838454038687, 6484.675766211576, 6595.208574971034, 6623.966880165568, 6299.11812346281, 6410.134631824644, 6505.934940650533, 6517.9348206517325, 6551.6069035858, 6454.806355809334, 6520.478361730955, 6526.738930442919, 6591.373819487141, 6591.538592298685, 6489.448396886318, 6503.25212600557, 6507.707153178024, 6508.414242718178, 6515.478761698958], "value": 6095.536606903837, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.7986533568605, 797.4378063465258, 814.2305521282389, 1195.7668254690334, 1262.614902454751, 36856.81571592142, 37331.813340933324, 37461.625383746155, 37475.0, 37542.0, 37638.623613763855, 38033.85898423045, 38104.42843357345, 38184.65414841918, 38309.61690383095, 7724.266194711493, 7840.803979900519, 8205.138460461656, 8252.587370631474, 8373.371997100212, 8294.0, 8396.11840756721, 8400.117987611304, 8401.075881653012, 8409.411341206118, 8338.916610833905, 8373.790655233606, 8416.452930559524, 8440.240378365947, 8452.873206901872, 8369.995600527976, 8375.20435558621, 8395.916040839575, 8400.705975290835, 8402.453840500348, 8223.54770487623, 8225.218604232588, 8280.668773249123, 8282.716178992267, 8301.543415112166, 36174.63825361739, 36609.084772880626, 36668.81665591655, 36755.0, 36787.264254715024, 3691.9261614767825, 3696.741228114033, 3738.0841693784923, 3738.2523495300775, 3741.8316175771884, 29816.0, 30346.393072138435, 30401.391972160432, 30437.695623043706, 30453.543196852064, 3135.7804953653254, 3165.6042994625673, 3170.5719727836677, 3178.507331363642, 3187.0, 236321.0, 239217.0, 269769.999999998, 281870.0, 284650.0, 46394.5360546397, 46759.53240467552, 46826.0, 46880.53119468762, 47092.05815883663, 47399.28901066487, 47970.80072998203, 48152.75923620429, 48244.758776206596, 48279.75860120677, 13697.520586779416, 13741.450341986409, 13903.4438622456, 13922.0, 13931.442742290195, 11149.0, 11277.492512836941, 11355.602553910574, 11390.430478476042, 11422.25755325901, 10778.784424311627, 11158.944205278922, 12999.1550549214, 13118.540851070167, 13140.211587304791, 5656.264685590847, 5754.0, 5862.296524417097, 5878.118282257696, 5883.617349922764, 1041.354360296621, 1049.1606714628267, 1049.3598904668147, 1078.1805827571102, 1088.9401082940356, 21847.781522184894, 23412.882935585214, 24586.0, 24621.38446538815, 24879.75601219932, 1144.7481554058095, 1149.115181310403, 1181.6159748081907, 1191.9821202681967, 1196.1029228078942, 12321.691957701129, 12471.93764031174, 12513.562025329069, 12544.059195560369, 12585.622431327074, 303094.0, 304325.0, 306353.0, 306428.0, 306559.0, 52333.7383313081, 52338.0, 52581.0, 52661.946761064566, 52746.73626631919, 1487.9956029679922, 1508.9924550377177, 1551.387202055182, 1558.4467514032583, 1563.366836431247, 23875.283741487783, 24001.519969600162, 24046.87976560106, 24065.75934240705, 24105.91523381417, 37342.0, 37409.81295093507, 37475.81262093672, 37535.249295013404, 37538.436923446716, 274059.0, 277074.0, 277378.83931741444, 277797.0, 278328.0, 32694.0, 33001.50497742584, 33042.66957330396, 33261.50538709558, 33370.83314583411, 41752.37371439492, 43661.56338436575, 43696.34455483107, 43704.0, 43735.78132109319, 28974.855125724236, 29446.705532944397, 29651.85174074116, 30664.540031899094, 30757.538636920017, 24051.0, 29953.85023074958, 30091.69908300889, 30284.09147725572, 30450.238744031576, 35401.114972125906, 35416.0, 36226.91319260426, 36248.09379765527, 36678.63321366752, 30394.392112158075, 30616.0, 30774.38451230918, 30779.230519237197, 31312.373752524367, 22590.531615444943, 24359.634605481286, 24409.26772196837, 24664.260072197863, 24752.50494990126], "value": 17274.058239140373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.37827691048057, 430.08821298846414, 433.694273821365, 438.3315443947979, 458.67663297375356, 19550.90224548879, 21066.578668426624, 21567.784322156775, 21825.781742182575, 21929.342119736393, 21569.0, 22065.227717029906, 22473.32580022598, 22616.321510354715, 23341.533169336602, 6107.999999999989, 6234.283057448383, 6276.905846412307, 6289.056641503766, 6296.779612713556, 5906.527477801787, 6158.107074474198, 6208.6585237811905, 6213.068039794044, 6220.906686399685, 6125.326214116466, 6126.203593532835, 6145.600535965148, 6178.814635560918, 6183.690815459231, 5689.118186681071, 5766.798162064329, 6080.847978800543, 6170.537209709245, 6205.7517699291975, 5322.2548843161985, 5497.147942068986, 5508.531774799147, 5526.419725928759, 5566.582506312002, 20630.0, 26684.33289167767, 27348.58977115345, 27875.0, 28246.71753282482, 2230.565039817236, 2306.0084163809556, 2308.180595888469, 2310.191432998454, 2316.8030717389042, 16964.745528816955, 17161.828381716146, 17361.47915562535, 17516.0, 17659.11704414774, 1884.594812115388, 2141.689455029012, 2142.2395049757424, 2176.8040876321047, 2178.7930146636045, 150039.24980375028, 154956.22521887432, 158280.41719582773, 159405.0, 159905.0, 11016.394098324668, 11177.217594768288, 12572.748545029232, 12680.492780288869, 12764.489420423079, 15975.60060998461, 16247.675046499004, 16255.59361015984, 16328.510144695678, 16363.181840907908, 7318.268173182639, 7461.925380746232, 8759.912400876037, 8992.0, 9142.085791420805, 7283.3809126223805, 8503.107173746792, 8525.0, 8725.476471411735, 8732.777411162442, 7019.684114214872, 7274.709011639581, 7691.115521714963, 7697.230276972258, 7729.536227826348, 2171.6742488626833, 2181.1166477576608, 2186.7047948527065, 2188.9014994325294, 2296.724393072842, 956.383132879289, 957.9808403831885, 965.9468729219819, 1027.6865556005341, 1032.0711359776262, 20012.600268872007, 20905.790942090385, 21146.83692396933, 21214.36356909295, 21321.78678213198, 898.9730308090768, 948.2461443152572, 987.8863930648067, 1023.9537376305432, 1043.186314674555, 8086.272235498834, 9814.558344874498, 9961.800763984824, 10661.893381066246, 10772.622958196425, 532760.0, 539219.0, 564353.0, 570993.0, 571201.0, 129607.05589416166, 131662.0, 132110.0, 133704.0, 137874.31062844623, 1206.3968015992004, 1247.6257122863105, 1262.141743614351, 1267.8034904589804, 1272.7072773262203, 20426.89786551117, 21604.35186944394, 21610.675839862728, 21610.91945402755, 21692.674609881182, 55834.44165558292, 56082.0, 56542.15186772119, 56751.31116477416, 57369.42630573641, 76823.0, 77559.83660244988, 78097.60951195208, 78644.60677696575, 79062.0, 8581.699640512801, 8754.824903502022, 8849.380543361904, 8870.822583548423, 8987.831581894574, 13195.472181112647, 13561.915046796035, 13575.913926885627, 13704.794428083387, 13869.09850859691, 9320.627174912928, 11687.824682629938, 11820.586279480176, 11947.088465845423, 12107.455164517794, 10829.187810914056, 10932.0, 10936.726581835517, 11064.446777661246, 11158.49786759614, 9524.95237523808, 11587.304761714324, 11986.220895642104, 12091.395430228278, 12102.576409825966, 7198.20819709821, 7684.46208765381, 8758.080401558, 8791.252743516618, 8933.240674542476, 11176.552937882394, 11934.985526230368, 12149.210301330386, 12159.574414895436, 12215.328156951453], "value": 10365.200247962779, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1182.6984119049641, 1197.3175290084655, 1362.8841548468379, 1428.8928330375225, 1446.8697817196464, 11009.0, 11373.829392559108, 11477.13921455891, 11516.581517881255, 11714.941425292884, 11505.654830355083, 11515.136364772634, 11668.299902005885, 11680.824787628171, 11689.473973671184, 2143.807057364837, 2507.5611767940627, 2535.1887396033185, 2557.552428325045, 2557.836184536041, 1869.775626924771, 2487.564676181661, 2512.811539134563, 2536.1757428835704, 2539.669842920427, 2491.314888405685, 2508.3227528567277, 2528.7091984421845, 2535.6069809179517, 2536.074332868508, 2397.137030668958, 2421.4914867877765, 2440.1825388494876, 2463.5319289335057, 2485.9129930452436, 2405.7113146422366, 2484.6148846928754, 2486.3038349262238, 2517.1064272183294, 2520.117958714454, 11505.0, 11588.01501872342, 11670.358130302915, 11690.47392867323, 11700.239484433485, 6586.538942274043, 6755.22314933779, 6840.0, 6847.623380714059, 6857.657117144173, 4089.488813898263, 4408.823647054114, 4442.8667139985855, 4450.933236001462, 4466.0, 1248.9937550312281, 1262.6022802817083, 1318.0378323823566, 1324.1790090144173, 1328.2628141381529, 16283.941543799734, 16612.83387166137, 16705.749413758804, 16825.83174168255, 16834.49496515094, 5557.3331200256225, 5644.5484361251, 5665.178549110356, 5806.796762113306, 5813.0, 11752.647420577396, 11826.290422574673, 11858.822117668242, 11866.228695134789, 11884.989775869148, 6519.674016299261, 6571.57284776488, 6579.506537009744, 6583.80248592543, 6587.604743715392, 6040.486558642477, 6077.665728384893, 6120.846978825565, 6224.253089629183, 6230.314665386803, 4316.223079845658, 4421.336799480104, 4448.5773851484055, 4451.310046942729, 4482.484514280834, 1069.657709532942, 1262.450833887262, 1281.814136950137, 1299.2789002103923, 1306.764782339188, 776.7514395393533, 799.7923136064468, 810.0643756461296, 814.7881550796835, 832.4006715165071, 5529.336479622471, 6185.536084793658, 6207.820514102306, 6382.627735036989, 6507.739690412331, 577.8150991682705, 587.5769445998959, 599.5653151465153, 609.9146119543268, 610.3774150366601, 4268.573142685768, 4325.935110973338, 4384.7369157850635, 4403.405540252089, 4426.933595996063, 14124.293785310694, 14798.852011479963, 14804.259787010822, 14811.925940370229, 14814.185219813015, 14372.85627143736, 14775.335109919864, 14924.92537537327, 14950.252487375805, 14960.551183464513, 7459.888101678479, 8489.490630562186, 8588.368210040073, 8685.652573896974, 8691.304695624334, 5942.257217847769, 6432.807015789534, 6920.0, 7076.823079423056, 7093.929060709327, 12961.351932403531, 13135.605931822061, 13145.145565538209, 13465.326733663082, 13512.864871351161, 11041.06150977176, 12477.563285284972, 13228.40472178735, 13524.256165910576, 13639.659008524866, 9274.165325120772, 9327.300452465957, 9379.249660027044, 9382.96787353377, 9435.952820235854, 10358.326708763907, 10588.311759735592, 10690.572377104829, 10698.946505267424, 10726.195535334726, 8975.596098175729, 9007.414518056305, 9209.493477858514, 9264.11990860867, 9359.06409359086, 8766.123387661439, 8943.284537237136, 8982.461052336881, 9007.864882026906, 9015.594298256725, 8167.959160204161, 8172.918270817216, 8196.016478022675, 8201.0, 8313.584320784057, 6009.038553831366, 6116.449519543263, 6139.3553676863285, 6168.0, 6240.344763799736, 6014.699265036643, 6069.666168360606, 6141.447269745566, 6195.81412557624, 6378.362163783585], "value": 5300.2632240608655, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.2159703100682, 403.4271334704719, 408.64652075954297, 408.7465771221843, 411.48153326808193, 5562.916556251655, 6163.753449862012, 6196.31840497546, 6266.965950618148, 6353.618782873025, 6127.938720612792, 6279.9904030710195, 6373.267074286458, 6377.649229292387, 6382.361763823627, 4815.614750819944, 4839.153148199069, 4840.9273860891935, 4845.127876982142, 4864.902701945959, 4727.950471945593, 4779.474257831635, 4827.493113223114, 4854.56308932196, 4864.829730959417, 3920.764754114748, 4178.477690288714, 4493.281075027996, 4791.448983366922, 4791.928121078169, 4785.617150627942, 4823.5176482351835, 4834.323194752737, 4850.466448690641, 4852.344933434012, 4123.773192474413, 4222.619964203206, 4256.297710877701, 4279.0, 4293.012607100353, 5077.64456488046, 5156.097682905476, 5286.920696189561, 5897.469227769521, 6232.470240029603, 4509.7970591323465, 5259.842204733826, 5534.916976245359, 5720.856978575527, 5736.770529178828, 6747.359000894956, 6820.420264277493, 6832.642738255294, 6855.314468553154, 6857.828554286133, 4079.673626109904, 4081.571434999312, 4291.914161716748, 4855.927161092586, 4868.829590964299, 6541.149650545399, 7023.227444981099, 7096.077509923729, 7173.6413179340825, 7196.784096477114, 4520.0, 4900.975495122501, 4950.3069570260195, 4954.925676114861, 4979.352684151109, 4006.659433948147, 4312.762798046075, 5074.492550744896, 5075.441701412841, 5076.416212135578, 5531.096174508335, 5574.58190635704, 5652.406497317805, 5706.28671416073, 5730.942690573041, 5831.79588714393, 5960.970195149083, 6880.415164710956, 6883.621400822903, 6906.412954898789, 1430.4564265579222, 1576.2670358283453, 1606.5903194685282, 1715.2452920715095, 1736.5311365931127, 1161.9593314233962, 1177.5760726138583, 1184.2302503372875, 1186.6143503361443, 1191.5531675621642, 6451.548391612542, 6456.903146452807, 6458.1906870511475, 6463.572452869799, 6538.8365290868105, 6834.692438840264, 6907.930920690829, 6984.755533556403, 7023.297670233038, 7036.296370363025, 6389.936100639027, 6409.327020662857, 6459.806205813833, 6467.2562655294305, 6476.838079048061, 3032.529957856536, 3248.3178532507964, 3615.746897717187, 3675.933979146018, 3681.3557627415094, 6098.695065246809, 6408.878446271884, 6984.476164287698, 7040.190378106481, 7256.96371518139, 7080.964595176991, 7199.496035277585, 7207.675654595556, 7255.709771609182, 7259.237780033126, 7355.852882942419, 7398.926010739931, 7413.184549699421, 7429.322485369777, 7431.628418578941, 6890.621015843976, 7124.358807707331, 7126.786196414116, 7129.394001509722, 7129.857402851811, 5779.36426993022, 6407.7640791400045, 7000.719971201095, 7022.419955509969, 7044.788656340318, 6454.0, 7032.437405007689, 7284.817879553054, 7391.1500177480275, 7465.253474652492, 4414.801333939916, 4425.645948324062, 4439.334099885043, 4467.106578684341, 4475.462944446687, 7138.892916606152, 7185.497015208885, 7190.496665233383, 7232.385247254042, 7283.417326613964, 5195.896082078413, 6060.727247277945, 6672.332766723289, 6805.829854253683, 6877.0, 5429.6199266051, 6809.965950170217, 6839.658017099225, 6867.931320686729, 6887.586744795329, 5551.361593416808, 6545.607263564201, 6703.826830304774, 6706.631135287606, 6748.932510675027, 5101.260317253903, 6442.35576442352, 6774.627395493295, 6883.965580172067, 6915.446764258948, 5620.819627878192, 6492.64290464029, 6562.671866406565, 6682.331766823473, 6694.665266736546], "value": 4991.957885744986, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.6809605917484, 845.281510715892, 856.0412338181238, 858.862581986882, 879.7068309584907, 16165.595860103489, 16582.92211006284, 16602.833971660293, 18488.075596220202, 19207.42377728667, 17630.735538966925, 17880.28478860844, 18063.72904406435, 18228.453146405594, 18539.629207415877, 972.4602845420789, 990.9108180263775, 992.831218692824, 994.0457161125329, 997.3866072365479, 989.65362123257, 1000.0299709281985, 1000.564754331868, 1001.2540657210352, 1003.2225025605178, 1058.5077938758475, 1058.6453538064718, 1058.6506452870535, 1059.7350662334416, 1060.8249638809586, 1044.3264094658941, 1052.5894900988621, 1053.8682664666917, 1054.7574057966672, 1057.1384321777764, 730.9853802923965, 758.1963119093779, 763.4922776353718, 766.5898744171841, 767.6161919040479, 16430.424935127212, 16579.0, 16596.08721520316, 16596.917015414965, 16600.50198494047, 17109.23008464622, 17178.914105429518, 17481.56296092608, 17599.472015839547, 17621.647567048716, 11024.724381890437, 13649.249291288976, 13888.23614701191, 13939.651508712263, 13944.790828137586, 3495.353359628477, 3553.6446355364515, 3555.7866528008403, 3562.750607457479, 3565.554305711786, 128252.0, 128675.0, 129759.0, 129967.45113921062, 132467.33766331107, 11936.641900742992, 13206.537771177962, 13274.867251327556, 13594.728105438033, 13608.115472494255, 25114.246572602486, 25187.36282141655, 25326.746732532807, 25363.619545706828, 25605.359866003128, 7681.5775132367135, 7726.575038372831, 7730.149683534807, 7786.610669466504, 7787.649555770004, 3331.9666803332143, 3996.540397854284, 4007.5992400760274, 4020.618041286073, 4024.1348110156455, 4295.656347492193, 4347.695661303678, 4384.495782984934, 4390.165868484977, 4393.648508119343, 875.7504111328241, 894.8702438146432, 898.1736802142045, 899.1143723432414, 900.6757567275776, 660.6663634864362, 683.8461346197165, 689.6034780001519, 690.8963655451722, 691.9757808476679, 10240.48797560119, 11171.72070698239, 11775.454572686634, 11900.226485278428, 11940.820887686692, 658.8682263547214, 660.8050625065617, 675.8107729835654, 682.4199430484148, 699.5872435263118, 4411.1618792429335, 5290.92063619046, 5378.273933019071, 5504.366997795225, 5505.532029777433, 84492.0, 101952.0, 110748.78502429907, 111074.0, 114218.0, 97702.02297977071, 98432.0, 99909.50045249728, 101150.48274275892, 102012.0, 85963.14036859677, 86603.74151360283, 86607.56696216478, 86684.56657716798, 87523.68714469289, 10819.242653014213, 10939.50772215268, 11047.337159770439, 11097.446357509794, 11356.54573817038, 43612.78193609012, 43684.78157609192, 44090.55909440993, 44800.77599612111, 44884.87787805331, 56071.719641403164, 56666.7166664164, 56957.715211423674, 57301.14048289362, 57691.423085770286, 13688.0, 13897.374618142007, 14067.788983165055, 14154.858451415354, 14174.433022678977, 15178.316975735897, 15318.693626127191, 15439.768403473732, 15532.456364027204, 15546.455874044354, 13864.376103075185, 13877.791833122714, 14174.574762757135, 14406.711865762836, 14411.207383593584, 14081.859181408465, 14103.435862565382, 14203.573892783234, 14259.429622815385, 14342.85657143457, 13075.084744067824, 13159.407826647632, 13464.932675336953, 13529.0, 13568.796468053184, 9140.771480712769, 9926.106650401498, 9986.151177149733, 10344.37933723979, 10722.356658600509, 9992.600295988079, 10494.160467162761, 11366.829497557708, 11562.248453850472, 12778.808317875053], "value": 8167.854378899414, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 124.0, 171.0, 169.0, 146.0, 114.0, 114.0, 115.0], "value": 127.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 104.0, 110.0, 147.0, 110.0, 111.0, 110.0, 111.0, 141.0, 146.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 203.0, 203.0, 206.0, 214.0, 231.0, 237.0, 264.0, 288.0, 204.0], "value": 224.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 61.0, 86.0, 63.0, 62.0, 57.0, 61.0, 76.0, 58.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 85.0, 92.0, 101.0, 101.0, 87.0, 71.0, 77.0, 90.0], "value": 86.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 90.0, 98.0, 90.0, 89.0, 89.0, 93.0, 113.0, 90.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 125.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 98.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 91.0, 91.0, 90.0, 90.0, 90.0, 94.0, 92.0, 94.0], "value": 91.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 52.0, 55.0, 54.0, 51.0, 52.0, 52.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 67.0, 57.0, 65.0, 92.0, 50.0, 54.0, 68.0, 85.0, 82.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 75.0, 116.0, 110.0, 73.0, 75.0, 92.0, 98.0, 116.0, 105.0], "value": 94.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 142.0, 149.0, 148.0, 134.0, 139.0, 144.0, 136.0, 201.0, 143.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 225.0, 166.0, 227.0, 232.0, 191.0, 181.0, 188.0, 174.0, 180.0], "value": 195.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 68.0, 70.0, 68.0, 70.0, 67.0, 88.0, 85.0, 71.0], "value": 72.8, "unit": "score"}]}]} 03:36:12 INFO - Return code: 0 03:36:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:36:12 INFO - # TBPL SUCCESS # 03:36:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:36:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:36:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:36:13 INFO - 2017-05-03 03:36:13.007 screenresolution[1680:10582] starting screenresolution argv=screenresolution get 03:36:13 INFO - 2017-05-03 03:36:13.010 screenresolution[1680:10582] Display 0: 1600x1200x32@60 03:36:13 INFO - 2017-05-03 03:36:13.016 screenresolution[1681:10585] starting screenresolution argv=screenresolution list 03:36:13 INFO - Available Modes on Display 0 03:36:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:36:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:36:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:36:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:36:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:36:13 INFO - Intel Iris: 03:36:13 INFO - Chipset Model: Intel Iris 03:36:13 INFO - Type: GPU 03:36:13 INFO - Bus: Built-In 03:36:13 INFO - VRAM (Dynamic, Max): 1536 MB 03:36:13 INFO - Vendor: Intel (0x8086) 03:36:13 INFO - Device ID: 0x0a2e 03:36:13 INFO - Revision ID: 0x0009 03:36:13 INFO - Displays: 03:36:13 INFO - Display: 03:36:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:36:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:36:13 INFO - Display Serial Number: 1600x1200 60 03:36:13 INFO - Main Display: Yes 03:36:13 INFO - Mirror: Off 03:36:13 INFO - Online: Yes 03:36:13 INFO - Rotation: Supported 03:36:13 INFO - Return code: 0 03:36:13 INFO - Running post-action listener: _resource_record_post_action 03:36:13 INFO - [mozharness: 2017-05-03 10:36:13.264782Z] Finished run-tests step (success) 03:36:13 INFO - Running post-run listener: _resource_record_post_run 03:36:13 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 40193024; Write bytes: 512990720; Read time: 407; Write time: 1803 03:36:13 INFO - TinderboxPrint: CPU usage
54.0% 03:36:13 INFO - TinderboxPrint: I/O read bytes / time
40,193,024 / 407 03:36:13 INFO - TinderboxPrint: I/O write bytes / time
512,990,720 / 1,803 03:36:13 INFO - TinderboxPrint: CPU idle
2,202.2 (46.0%) 03:36:13 INFO - TinderboxPrint: CPU system
957.5 (20.0%) 03:36:13 INFO - TinderboxPrint: CPU user
1,626.0 (34.0%) 03:36:13 INFO - TinderboxPrint: Swap in / out
249,294,848 / 0 03:36:13 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209633792; Write bytes: 212362752; Read time: 15969; Write time: 495 03:36:13 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 35281920; Write bytes: 299132928; Read time: 371; Write time: 1301 03:36:13 INFO - Running post-run listener: _upload_blobber_files 03:36:13 INFO - Blob upload gear active. 03:36:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:36:13 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 03:36:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:36:14 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:15 INFO - (blobuploader) - INFO - Done attempting. 03:36:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:36:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:36:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:16 INFO - (blobuploader) - INFO - Done attempting. 03:36:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:36:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:36:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:17 INFO - (blobuploader) - INFO - Done attempting. 03:36:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:36:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:36:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:19 INFO - (blobuploader) - INFO - Done attempting. 03:36:19 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:19 INFO - Return code: 0 03:36:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a73c4e784b4cbbbe1426d270e29f6a114dd90e08b8a1058a9bc2eba0049c8099a6a689a7a9e370f631c7188b0cc2e8d00e2bfa00cbb7b18bf515b525272ad02e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d3bd75ba88dc42e32ece2ba66ab751d83a9b6c1b8d89c9fd97b976eddcc4eac552aab88e2c15d1c47fa097d09b32079274a949a1f59c742302aff35fb425f7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f07b08d033e82ded5d32bb12ac1242f3744852ee1c65f1565eeaa624825869ee58d0f92d713d47d6c89e9ea0af1593a558547b985d072611eb60cca27ff293d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bc6a025dcbd5c563b4d5281ecc6ed1f9e53a7944859ba61f23bf90b4e4afc852921d0f49e0811b23435dffa14eb8264b9048be67eb7c16cec76edeb95bd29b5"} 03:36:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:19 INFO - Contents: 03:36:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a73c4e784b4cbbbe1426d270e29f6a114dd90e08b8a1058a9bc2eba0049c8099a6a689a7a9e370f631c7188b0cc2e8d00e2bfa00cbb7b18bf515b525272ad02e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d3bd75ba88dc42e32ece2ba66ab751d83a9b6c1b8d89c9fd97b976eddcc4eac552aab88e2c15d1c47fa097d09b32079274a949a1f59c742302aff35fb425f7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f07b08d033e82ded5d32bb12ac1242f3744852ee1c65f1565eeaa624825869ee58d0f92d713d47d6c89e9ea0af1593a558547b985d072611eb60cca27ff293d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bc6a025dcbd5c563b4d5281ecc6ed1f9e53a7944859ba61f23bf90b4e4afc852921d0f49e0811b23435dffa14eb8264b9048be67eb7c16cec76edeb95bd29b5"} 03:36:19 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:19 INFO - Copying logs to upload dir... 03:36:19 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.882228 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-05-03 03:36:19.985687) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 03:36:19.988891) ========= 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.67ADPSWVHF/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.1e0BeqaVYW/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a73c4e784b4cbbbe1426d270e29f6a114dd90e08b8a1058a9bc2eba0049c8099a6a689a7a9e370f631c7188b0cc2e8d00e2bfa00cbb7b18bf515b525272ad02e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d3bd75ba88dc42e32ece2ba66ab751d83a9b6c1b8d89c9fd97b976eddcc4eac552aab88e2c15d1c47fa097d09b32079274a949a1f59c742302aff35fb425f7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f07b08d033e82ded5d32bb12ac1242f3744852ee1c65f1565eeaa624825869ee58d0f92d713d47d6c89e9ea0af1593a558547b985d072611eb60cca27ff293d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bc6a025dcbd5c563b4d5281ecc6ed1f9e53a7944859ba61f23bf90b4e4afc852921d0f49e0811b23435dffa14eb8264b9048be67eb7c16cec76edeb95bd29b5"} build_url:https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011069 build_url: 'https://queue.taskcluster.net/v1/task/Pmo1U-snTgSY8TGY-jyc6g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a73c4e784b4cbbbe1426d270e29f6a114dd90e08b8a1058a9bc2eba0049c8099a6a689a7a9e370f631c7188b0cc2e8d00e2bfa00cbb7b18bf515b525272ad02e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d3bd75ba88dc42e32ece2ba66ab751d83a9b6c1b8d89c9fd97b976eddcc4eac552aab88e2c15d1c47fa097d09b32079274a949a1f59c742302aff35fb425f7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f07b08d033e82ded5d32bb12ac1242f3744852ee1c65f1565eeaa624825869ee58d0f92d713d47d6c89e9ea0af1593a558547b985d072611eb60cca27ff293d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bc6a025dcbd5c563b4d5281ecc6ed1f9e53a7944859ba61f23bf90b4e4afc852921d0f49e0811b23435dffa14eb8264b9048be67eb7c16cec76edeb95bd29b5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 03:36:20.025229) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 03:36:20.025614) ========= 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.67ADPSWVHF/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.1e0BeqaVYW/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.005186 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 03:36:20.139600) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 03:36:20.139962) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 03:36:20.140425) ========= ========= Total master_lag: 0.26 =========