builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0299 starttime: 1494340865.23 results: success (0) revision: b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:05.231505) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:05.231929) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:05.232202) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:05.258300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:05.258602) ========= 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.ijTvTei6hR/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.L1KKwGjwWB/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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-09 07:41:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.5M=0.001s 2017-05-09 07:41:05 (19.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087770 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:05.372649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:05.373150) ========= 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.ijTvTei6hR/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.L1KKwGjwWB/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.026427 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:05.423647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:05.424153) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ijTvTei6hR/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.L1KKwGjwWB/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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-09 07:41:05,527 truncating revision to first 12 chars 2017-05-09 07:41:05,527 Setting DEBUG logging. 2017-05-09 07:41:05,528 attempt 1/10 2017-05-09 07:41:05,528 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b0ff0c5c0a35?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 07:41:05,858 unpacking tar archive at: mozilla-central-b0ff0c5c0a35/testing/mozharness/ program finished with exit code 0 elapsedTime=0.621516 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:06.068553) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:06.068887) ========= script_repo_revision: b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:06.069248) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:06.069584) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 07:41:06.090157) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-05-09 07:41:06.090587) ========= /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.ijTvTei6hR/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.L1KKwGjwWB/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:41:06 INFO - MultiFileLogger online at 20170509 07:41:06 in /builds/slave/test 07:41: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 07:41:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:41:06 INFO - {'append_to_log': False, 07:41:06 INFO - 'base_work_dir': '/builds/slave/test', 07:41:06 INFO - 'blob_upload_branch': 'Firefox', 07:41:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:41:06 INFO - 'branch': 'Firefox', 07:41:06 INFO - 'buildbot_json_path': 'buildprops.json', 07:41:06 INFO - 'config_files': ('talos/mac_config.py',), 07:41:06 INFO - 'default_actions': ('clobber', 07:41:06 INFO - 'read-buildbot-config', 07:41:06 INFO - 'download-and-extract', 07:41:06 INFO - 'populate-webroot', 07:41:06 INFO - 'create-virtualenv', 07:41:06 INFO - 'install', 07:41:06 INFO - 'run-tests'), 07:41:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:41:06 INFO - 'download_minidump_stackwalk': True, 07:41:06 INFO - 'download_symbols': 'ondemand', 07:41:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:41:06 INFO - 'tooltool.py': '/tools/tooltool.py', 07:41:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:41:06 INFO - '/tools/misc-python/virtualenv.py')}, 07:41:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:41:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:41:06 INFO - 'gecko_profile': False, 07:41:06 INFO - 'gecko_profile_interval': 0, 07:41:06 INFO - 'installer_path': 'installer.exe', 07:41:06 INFO - 'log_level': 'info', 07:41:06 INFO - 'log_name': 'talos', 07:41:06 INFO - 'log_to_console': True, 07:41:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:41:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:41:06 INFO - 'opt_config_files': (), 07:41:06 INFO - 'pip_index': False, 07:41:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:41:06 INFO - 'cmd': ('bash', 07:41:06 INFO - '-c', 07:41:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:41:06 INFO - 'enabled': True, 07:41:06 INFO - 'halt_on_failure': False, 07:41:06 INFO - 'name': 'check_screen_resolution'},), 07:41:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:41:06 INFO - 'cmd': ('bash', 07:41:06 INFO - '-c', 07:41:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:41:06 INFO - 'enabled': True, 07:41:06 INFO - 'halt_on_failure': False, 07:41:06 INFO - 'name': 'check_screen_resolution'},), 07:41:06 INFO - 'run_cmd_checks_enabled': True, 07:41:06 INFO - 'suite': 'dromaeojs-e10s', 07:41:06 INFO - 'system_bits': '32', 07:41:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:41:06 INFO - 'title': 't-yosemite-r7-0299', 07:41:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:41:06 INFO - 'use_talos_json': True, 07:41:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:41:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:41:06 INFO - 'work_dir': 'build'} 07:41:06 INFO - [mozharness: 2017-05-09 14:41:06.305550Z] Running clobber step. 07:41:06 INFO - Running pre-action listener: _resource_record_pre_action 07:41:06 INFO - Running main action method: clobber 07:41:06 INFO - rmtree: /builds/slave/test/build 07:41:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:41:08 INFO - Running post-action listener: _resource_record_post_action 07:41:08 INFO - [mozharness: 2017-05-09 14:41:08.816320Z] Finished clobber step (success) 07:41:08 INFO - [mozharness: 2017-05-09 14:41:08.816534Z] Running read-buildbot-config step. 07:41:08 INFO - Running pre-action listener: _resource_record_pre_action 07:41:08 INFO - Running main action method: read_buildbot_config 07:41:08 INFO - Using buildbot properties: 07:41:08 INFO - { 07:41:08 INFO - "project": "", 07:41:08 INFO - "product": "firefox", 07:41:08 INFO - "who": "cbook@mozilla.com", 07:41:08 INFO - "installer_path": "public/build/firefox-55.0a1.en-US.mac.dmg", 07:41:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:41:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:41:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:41:08 INFO - "stage_platform": "macosx64", 07:41:08 INFO - "basedir": "/builds/slave/test", 07:41:08 INFO - "buildnumber": 149, 07:41:08 INFO - "platform": "yosemite_r7", 07:41:08 INFO - "parent_task_id": "NXfWR7PoTJOKXN4EWbj3gw", 07:41:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:41:08 INFO - "slavebuilddir": "test", 07:41:08 INFO - "taskId": "HVwtiIp7RVmDhSSaHsOM1A", 07:41:08 INFO - "branch": "mozilla-central", 07:41:08 INFO - "script_repo_revision": "production", 07:41:08 INFO - "revision": "b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6", 07:41:08 INFO - "slavename": "t-yosemite-r7-0299", 07:41:08 INFO - "repo_path": "mozilla-central" 07:41:08 INFO - } 07:41:08 INFO - Finding installer, test and symbols from parent task. 07:41:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVwtiIp7RVmDhSSaHsOM1A'}, attempt #1 07:41:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVwtiIp7RVmDhSSaHsOM1A'}, attempt #1 07:41:10 INFO - Task dependencies: K0LrCheBTTyc1kAZ2KYw1Q 07:41:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw'}, attempt #1 07:41:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:41:10 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/test_packages.json 07:41:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/target.crashreporter-symbols.zip 07:41:10 INFO - Running post-action listener: _resource_record_post_action 07:41:10 INFO - [mozharness: 2017-05-09 14:41:10.615209Z] Finished read-buildbot-config step (success) 07:41:10 INFO - [mozharness: 2017-05-09 14:41:10.615333Z] Running download-and-extract step. 07:41:10 INFO - Running pre-action listener: _resource_record_pre_action 07:41:10 INFO - Running main action method: download_and_extract 07:41:10 INFO - mkdir: /builds/slave/test/build/tests 07:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:10 INFO - trying https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 07:41:10 INFO - Downloading https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/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 07:41:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/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 07:41:11 INFO - Downloaded 1325 bytes. 07:41:11 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 07:41:11 INFO - Using the following test package requirements: 07:41:11 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:41:11 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 07:41:11 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:41:11 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:41:11 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 07:41:11 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:41:11 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 07:41:11 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:41:11 INFO - u'jsshell-mac.zip'], 07:41:11 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:41:11 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 07:41:11 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:41:11 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:41:11 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 07:41:11 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:41:11 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 07:41:11 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:41:11 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 07:41:11 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:41:11 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 07:41:11 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:41:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:41:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:41:11 INFO - Fetch https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:41:13 INFO - Content-Length response header: 52710518 07:41:13 INFO - Bytes received: 52710518 07:41:29 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 07:41:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:41:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:41:29 INFO - Fetch https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:41:30 INFO - Content-Length response header: 52710518 07:41:30 INFO - Bytes received: 52710518 07:41:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 07:41:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:41:46 INFO - Fetch https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 07:41:47 INFO - Content-Length response header: 14409362 07:41:47 INFO - Bytes received: 14409362 07:41: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')]} 07:41:47 INFO - trying https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:41:47 INFO - Downloading https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 07:41:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/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 07:41:49 INFO - Downloaded 70710269 bytes. 07:41:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:41:49 INFO - mkdir: /builds/slave/test/properties 07:41:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:41:49 INFO - Writing to file /builds/slave/test/properties/build_url 07:41:49 INFO - Contents: 07:41:49 INFO - build_url:https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:41:49 INFO - Running post-action listener: _resource_record_post_action 07:41:49 INFO - Running post-action listener: set_extra_try_arguments 07:41:49 INFO - [mozharness: 2017-05-09 14:41:49.434015Z] Finished download-and-extract step (success) 07:41:49 INFO - [mozharness: 2017-05-09 14:41:49.434150Z] Running populate-webroot step. 07:41:49 INFO - Running pre-action listener: _resource_record_pre_action 07:41:49 INFO - Running main action method: populate_webroot 07:41:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:41:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:41:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:41:49 INFO - '--tppagecycles', 07:41:49 INFO - '7'], 07:41:49 INFO - 'tests': ['tsvgm']}}, 07:41:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:41:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:41:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:41:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:41:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:41:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:41:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:41:49 INFO - 'talos_options': ['--disable-e10s'], 07:41:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:41:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:41:49 INFO - 'talos_options': ['--disable-e10s'], 07:41:49 INFO - 'tests': ['damp', 'tps']}, 07:41:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:41:49 INFO - 'tests': ['damp', 'tps']}, 07:41:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:41:49 INFO - 'tests': ['dromaeo_dom']}, 07:41:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:41:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:41:49 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:41:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:41:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:41:49 INFO - 'tests': ['a11yr', 07:41:49 INFO - 'ts_paint', 07:41:49 INFO - 'tpaint', 07:41:49 INFO - 'sessionrestore', 07:41:49 INFO - 'sessionrestore_no_auto_restore', 07:41:49 INFO - 'tabpaint']}, 07:41:49 INFO - 'other-e10s': {'tests': ['a11yr', 07:41:49 INFO - 'ts_paint', 07:41:49 INFO - 'tpaint', 07:41:49 INFO - 'sessionrestore', 07:41:49 INFO - 'sessionrestore_no_auto_restore', 07:41:49 INFO - 'tabpaint']}, 07:41:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:41:49 INFO - 'ts_paint', 07:41:49 INFO - 'tpaint', 07:41:49 INFO - 'sessionrestore', 07:41:49 INFO - 'sessionrestore_no_auto_restore', 07:41:49 INFO - 'tabpaint']}, 07:41:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:41:49 INFO - 'ts_paint', 07:41:49 INFO - 'tpaint', 07:41:49 INFO - 'sessionrestore', 07:41:49 INFO - 'sessionrestore_no_auto_restore', 07:41:49 INFO - 'tabpaint']}, 07:41:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:41:49 INFO - 'tests': ['a11yr', 07:41:49 INFO - 'ts_paint', 07:41:49 INFO - 'tpaint', 07:41:49 INFO - 'sessionrestore', 07:41:49 INFO - 'sessionrestore_no_auto_restore', 07:41:49 INFO - 'tabpaint']}, 07:41:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:41:49 INFO - 'tests': ['a11yr', 07:41:49 INFO - 'ts_paint', 07:41:49 INFO - 'tpaint', 07:41:49 INFO - 'sessionrestore', 07:41:49 INFO - 'sessionrestore_no_auto_restore', 07:41:49 INFO - 'tabpaint']}, 07:41:49 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 07:41:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 07:41:49 INFO - 'bloom_basic_ref']}, 07:41:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:41:49 INFO - 'tests': ['tsvgx', 07:41:49 INFO - 'tsvgr_opacity', 07:41:49 INFO - 'tart', 07:41:49 INFO - 'tscrollx', 07:41:49 INFO - 'cart', 07:41:49 INFO - 'tsvg_static']}, 07:41:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:41:49 INFO - 'tsvgr_opacity', 07:41:49 INFO - 'tart', 07:41:49 INFO - 'tscrollx', 07:41:49 INFO - 'cart', 07:41:49 INFO - 'tsvg_static']}, 07:41:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:41:49 INFO - 'talos_options': ['--disable-e10s'], 07:41:49 INFO - 'tests': ['tp5o']}, 07:41:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:41:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:41:49 INFO - 'talos_options': ['--disable-e10s', 07:41:49 INFO - '--xperf_path', 07:41:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:49 INFO - 'tests': ['tp5n']}, 07:41:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:41:49 INFO - 'talos_options': ['--xperf_path', 07:41:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:49 INFO - 'tests': ['tp5n']}}, 07:41:49 INFO - 'talos.zip': {'path': '', 07:41:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:41:49 INFO - Running post-action listener: _resource_record_post_action 07:41:49 INFO - [mozharness: 2017-05-09 14:41:49.455552Z] Finished populate-webroot step (success) 07:41:49 INFO - [mozharness: 2017-05-09 14:41:49.455693Z] Running create-virtualenv step. 07:41:49 INFO - Running pre-action listener: _resource_record_pre_action 07:41:49 INFO - Running main action method: create_virtualenv 07:41:49 INFO - Creating virtualenv /builds/slave/test/build/venv 07:41: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 07:41:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:41:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:41:49 INFO - Using real prefix '/tools/python27' 07:41:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:41:50 INFO - Installing distribute.............................................................................................................................................................................................done. 07:41:53 INFO - Installing pip.................done. 07:41:53 INFO - Return code: 0 07:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:41:53 INFO - Reading from file tmpfile_stdout 07:41:53 INFO - Output received: 07:41: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) 07:41:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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 0x107690b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107693768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a58cf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073a1d30>, '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 0x107354db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107395be8>, '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.ijTvTei6hR/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.L1KKwGjwWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:41: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 07:41: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 07:41:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijTvTei6hR/Render', 07:41:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:53 INFO - 'HOME': '/Users/cltbld', 07:41:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:53 INFO - 'LOGNAME': 'cltbld', 07:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:53 INFO - 'MOZ_NO_REMOTE': '1', 07:41:53 INFO - 'NO_EM_RESTART': '1', 07:41:53 INFO - 'PAGER': '/bin/cat', 07:41:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:53 INFO - 'PWD': '/builds/slave/test', 07:41:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:53 INFO - 'SHELL': '/bin/bash', 07:41:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1KKwGjwWB/Listeners', 07:41:53 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:41:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:53 INFO - 'USER': 'cltbld', 07:41:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:53 INFO - 'XPC_FLAGS': '0x0', 07:41:53 INFO - 'XPC_SERVICE_NAME': '0', 07:41:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:41:53 INFO - Cleaning up... 07:41:53 INFO - Return code: 0 07:41:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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', '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 0x107690b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107693768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a58cf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073a1d30>, '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 0x107354db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107395be8>, '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.ijTvTei6hR/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.L1KKwGjwWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:41: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:41: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 psutil>=3.1.1 07:41:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijTvTei6hR/Render', 07:41:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:53 INFO - 'HOME': '/Users/cltbld', 07:41:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:53 INFO - 'LOGNAME': 'cltbld', 07:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:53 INFO - 'MOZ_NO_REMOTE': '1', 07:41:53 INFO - 'NO_EM_RESTART': '1', 07:41:53 INFO - 'PAGER': '/bin/cat', 07:41:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:53 INFO - 'PWD': '/builds/slave/test', 07:41:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:53 INFO - 'SHELL': '/bin/bash', 07:41:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1KKwGjwWB/Listeners', 07:41:53 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:41:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:53 INFO - 'USER': 'cltbld', 07:41:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:53 INFO - 'XPC_FLAGS': '0x0', 07:41:53 INFO - 'XPC_SERVICE_NAME': '0', 07:41:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:53 INFO - Downloading/unpacking psutil>=3.1.1 07:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:41:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:56 INFO - Installing collected packages: psutil 07:41:56 INFO - Running setup.py install for psutil 07:41:56 INFO - building 'psutil._psutil_osx' extension 07:41: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 07:41: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 07:41: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 07:41: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 07:41:57 INFO - building 'psutil._psutil_posix' extension 07:41: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 07:41:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:41:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:41:57 INFO - ^ 07:41:57 INFO - 1 warning generated. 07:41: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 07:41:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:57 INFO - Successfully installed psutil 07:41:57 INFO - Cleaning up... 07:41:57 INFO - Return code: 0 07:41:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:58 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 0x107690b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107693768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a58cf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073a1d30>, '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 0x107354db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107395be8>, '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.ijTvTei6hR/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.L1KKwGjwWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:41:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:41:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijTvTei6hR/Render', 07:41:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:58 INFO - 'HOME': '/Users/cltbld', 07:41:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:58 INFO - 'LOGNAME': 'cltbld', 07:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:58 INFO - 'MOZ_NO_REMOTE': '1', 07:41:58 INFO - 'NO_EM_RESTART': '1', 07:41:58 INFO - 'PAGER': '/bin/cat', 07:41:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:58 INFO - 'PWD': '/builds/slave/test', 07:41:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:58 INFO - 'SHELL': '/bin/bash', 07:41:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1KKwGjwWB/Listeners', 07:41:58 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:41:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:58 INFO - 'USER': 'cltbld', 07:41:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:58 INFO - 'XPC_FLAGS': '0x0', 07:41:58 INFO - 'XPC_SERVICE_NAME': '0', 07:41:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:42:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:42:00 INFO - Installing collected packages: mozsystemmonitor 07:42:00 INFO - Running setup.py install for mozsystemmonitor 07:42:00 INFO - Successfully installed mozsystemmonitor 07:42:00 INFO - Cleaning up... 07:42:00 INFO - Return code: 0 07:42:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:00 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 0x107690b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107693768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a58cf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073a1d30>, '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 0x107354db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107395be8>, '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.ijTvTei6hR/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.L1KKwGjwWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:42:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijTvTei6hR/Render', 07:42:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:00 INFO - 'HOME': '/Users/cltbld', 07:42:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:00 INFO - 'LOGNAME': 'cltbld', 07:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:00 INFO - 'MOZ_NO_REMOTE': '1', 07:42:00 INFO - 'NO_EM_RESTART': '1', 07:42:00 INFO - 'PAGER': '/bin/cat', 07:42:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:00 INFO - 'PWD': '/builds/slave/test', 07:42:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:00 INFO - 'SHELL': '/bin/bash', 07:42:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1KKwGjwWB/Listeners', 07:42:00 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:42:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:00 INFO - 'USER': 'cltbld', 07:42:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:00 INFO - 'XPC_FLAGS': '0x0', 07:42:00 INFO - 'XPC_SERVICE_NAME': '0', 07:42:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:00 INFO - Downloading/unpacking jsonschema==2.5.1 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:42:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42:03 INFO - Downloading functools32-3.2.3-2.tar.gz 07:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:42:03 INFO - warning: no files found matching '*.txt' 07:42:03 INFO - no previously-included directories found matching 'build' 07:42:03 INFO - no previously-included directories found matching 'dist' 07:42:03 INFO - no previously-included directories found matching '.git*' 07:42:03 INFO - Installing collected packages: jsonschema, functools32 07:42:03 INFO - Running setup.py install for functools32 07:42:03 INFO - warning: no files found matching '*.txt' 07:42:03 INFO - no previously-included directories found matching 'build' 07:42:03 INFO - no previously-included directories found matching 'dist' 07:42:03 INFO - no previously-included directories found matching '.git*' 07:42:03 INFO - Successfully installed jsonschema functools32 07:42:03 INFO - Cleaning up... 07:42:03 INFO - Return code: 0 07:42:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42: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', '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 0x107690b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107693768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a58cf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073a1d30>, '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 0x107354db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107395be8>, '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.ijTvTei6hR/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.L1KKwGjwWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:42: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 functools32==3.2.3-2 07:42:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijTvTei6hR/Render', 07:42:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:03 INFO - 'HOME': '/Users/cltbld', 07:42:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:03 INFO - 'LOGNAME': 'cltbld', 07:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:03 INFO - 'MOZ_NO_REMOTE': '1', 07:42:03 INFO - 'NO_EM_RESTART': '1', 07:42:03 INFO - 'PAGER': '/bin/cat', 07:42:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:03 INFO - 'PWD': '/builds/slave/test', 07:42:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:03 INFO - 'SHELL': '/bin/bash', 07:42:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1KKwGjwWB/Listeners', 07:42:03 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:42:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:03 INFO - 'USER': 'cltbld', 07:42:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:03 INFO - 'XPC_FLAGS': '0x0', 07:42:03 INFO - 'XPC_SERVICE_NAME': '0', 07:42:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:42:04 INFO - Cleaning up... 07:42:04 INFO - Return code: 0 07:42:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107690b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107693768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a58cf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073a1d30>, '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 0x107354db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107395be8>, '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.ijTvTei6hR/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.L1KKwGjwWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:42:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijTvTei6hR/Render', 07:42:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:04 INFO - 'HOME': '/Users/cltbld', 07:42:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:04 INFO - 'LOGNAME': 'cltbld', 07:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:04 INFO - 'MOZ_NO_REMOTE': '1', 07:42:04 INFO - 'NO_EM_RESTART': '1', 07:42:04 INFO - 'PAGER': '/bin/cat', 07:42:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:04 INFO - 'PWD': '/builds/slave/test', 07:42:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:04 INFO - 'SHELL': '/bin/bash', 07:42:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1KKwGjwWB/Listeners', 07:42:04 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:42:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:04 INFO - 'USER': 'cltbld', 07:42:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:04 INFO - 'XPC_FLAGS': '0x0', 07:42:04 INFO - 'XPC_SERVICE_NAME': '0', 07:42:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:04 INFO - Downloading/unpacking blobuploader==1.2.4 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42:05 INFO - Downloading blobuploader-1.2.4.tar.gz 07:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:42:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:42:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:06 INFO - Downloading docopt-0.6.1.tar.gz 07:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:42:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:42:06 INFO - Running setup.py install for blobuploader 07:42:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:42:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:42:06 INFO - Running setup.py install for requests 07:42:07 INFO - Running setup.py install for docopt 07:42:07 INFO - Successfully installed blobuploader requests docopt 07:42:07 INFO - Cleaning up... 07:42:07 INFO - Return code: 0 07:42:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42: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')]} 07:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42: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')]} 07:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42: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 0x107690b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107693768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a58cf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073a1d30>, '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 0x107354db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107395be8>, '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.ijTvTei6hR/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.L1KKwGjwWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42: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 07:42: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 07:42:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijTvTei6hR/Render', 07:42:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:07 INFO - 'HOME': '/Users/cltbld', 07:42:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:07 INFO - 'LOGNAME': 'cltbld', 07:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:07 INFO - 'MOZ_NO_REMOTE': '1', 07:42:07 INFO - 'NO_EM_RESTART': '1', 07:42:07 INFO - 'PAGER': '/bin/cat', 07:42:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:07 INFO - 'PWD': '/builds/slave/test', 07:42:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:07 INFO - 'SHELL': '/bin/bash', 07:42:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1KKwGjwWB/Listeners', 07:42:07 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:42:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:07 INFO - 'USER': 'cltbld', 07:42:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:07 INFO - 'XPC_FLAGS': '0x0', 07:42:07 INFO - 'XPC_SERVICE_NAME': '0', 07:42:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:07 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-BhoXdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:08 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-xClQzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:08 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-j85v07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:08 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-4nrfvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:08 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-1w0AOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:08 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-klY9IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:08 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-9ohmu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:08 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-qrtyyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:08 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-qAtFtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:08 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-CCIACt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:09 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-llVxFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:09 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-rgUvlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:09 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-OX1VX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:09 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-eedaUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:09 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-s5xaeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:09 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-HeHE6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:09 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-NCABuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:42:09 INFO - Running setup.py install for manifestparser 07:42:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:42:09 INFO - Running setup.py install for mozcrash 07:42:10 INFO - Running setup.py install for mozdebug 07:42:10 INFO - Running setup.py install for mozdevice 07:42:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:42:10 INFO - Running setup.py install for mozfile 07:42:10 INFO - Running setup.py install for mozhttpd 07:42:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:42:10 INFO - Running setup.py install for mozinfo 07:42:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:42:10 INFO - Running setup.py install for mozInstall 07:42:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:42:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:42:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:42:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:42:10 INFO - Running setup.py install for mozleak 07:42:11 INFO - Running setup.py install for mozlog 07:42:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Running setup.py install for moznetwork 07:42:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Running setup.py install for mozprocess 07:42:11 INFO - Running setup.py install for mozprofile 07:42:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Running setup.py install for mozrunner 07:42:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Running setup.py install for mozscreenshot 07:42:12 INFO - Running setup.py install for moztest 07:42:12 INFO - Running setup.py install for mozversion 07:42:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:42:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:42:12 INFO - Cleaning up... 07:42:12 INFO - Return code: 0 07:42:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:12 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 0x107690b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107693768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a58cf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073a1d30>, '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 0x107354db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107395be8>, '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.ijTvTei6hR/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.L1KKwGjwWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:42:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijTvTei6hR/Render', 07:42:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:12 INFO - 'HOME': '/Users/cltbld', 07:42:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:12 INFO - 'LOGNAME': 'cltbld', 07:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:12 INFO - 'MOZ_NO_REMOTE': '1', 07:42:12 INFO - 'NO_EM_RESTART': '1', 07:42:12 INFO - 'PAGER': '/bin/cat', 07:42:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:12 INFO - 'PWD': '/builds/slave/test', 07:42:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:12 INFO - 'SHELL': '/bin/bash', 07:42:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1KKwGjwWB/Listeners', 07:42:12 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:42:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:12 INFO - 'USER': 'cltbld', 07:42:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:12 INFO - 'XPC_FLAGS': '0x0', 07:42:12 INFO - 'XPC_SERVICE_NAME': '0', 07:42:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:12 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-9Aydxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42: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)) 07:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:12 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-_XxhSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42: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)) 07:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:12 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-WYegaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42: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)) 07:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:12 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-m1tl9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:13 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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:13 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-l4D5xP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:13 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-wWXRIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:13 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-Rwjy_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:13 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-9Y5C6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42: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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:13 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-PymjdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42: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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:13 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-c3HmE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42: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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:13 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-bUVBdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42: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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:13 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-YpLjZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42: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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:13 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-UJKxpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42: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)) 07:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:13 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-GyZteP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:14 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-FD2_gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:14 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-pieEOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:14 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)) 07:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:14 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-f33d16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42: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)) 07:42: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)) 07:42: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)) 07:42: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)) 07:42: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)) 07:42: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)) 07:42:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42:15 INFO - Downloading blessings-1.6.tar.gz 07:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:42:15 INFO - Installing collected packages: blessings 07:42:15 INFO - Running setup.py install for blessings 07:42:16 INFO - Successfully installed blessings 07:42:16 INFO - Cleaning up... 07:42:16 INFO - Return code: 0 07:42:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:42:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:16 INFO - Reading from file tmpfile_stdout 07:42:16 INFO - Current package versions: 07:42:16 INFO - blessings == 1.6 07:42:16 INFO - blobuploader == 1.2.4 07:42:16 INFO - docopt == 0.6.1 07:42:16 INFO - functools32 == 3.2.3-2 07:42:16 INFO - jsonschema == 2.5.1 07:42:16 INFO - manifestparser == 1.1 07:42:16 INFO - mozInstall == 1.12 07:42:16 INFO - mozcrash == 1.0 07:42:16 INFO - mozdebug == 0.1 07:42:16 INFO - mozdevice == 0.50 07:42:16 INFO - mozfile == 1.2 07:42:16 INFO - mozhttpd == 0.7 07:42:16 INFO - mozinfo == 0.9 07:42:16 INFO - mozleak == 0.1 07:42:16 INFO - mozlog == 3.4 07:42:16 INFO - moznetwork == 0.27 07:42:16 INFO - mozprocess == 0.25 07:42:16 INFO - mozprofile == 0.28 07:42:16 INFO - mozrunner == 6.13 07:42:16 INFO - mozscreenshot == 0.1 07:42:16 INFO - mozsystemmonitor == 0.3 07:42:16 INFO - moztest == 0.8 07:42:16 INFO - mozversion == 1.4 07:42:16 INFO - psutil == 3.1.1 07:42:16 INFO - requests == 1.2.3 07:42:16 INFO - wsgiref == 0.1.2 07:42:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:16 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 0x107690b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107693768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a58cf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073a1d30>, '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 0x107354db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107395be8>, '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.ijTvTei6hR/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.L1KKwGjwWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:42:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijTvTei6hR/Render', 07:42:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:16 INFO - 'HOME': '/Users/cltbld', 07:42:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:16 INFO - 'LOGNAME': 'cltbld', 07:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:16 INFO - 'MOZ_NO_REMOTE': '1', 07:42:16 INFO - 'NO_EM_RESTART': '1', 07:42:16 INFO - 'PAGER': '/bin/cat', 07:42:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:16 INFO - 'PWD': '/builds/slave/test', 07:42:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:16 INFO - 'SHELL': '/bin/bash', 07:42:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1KKwGjwWB/Listeners', 07:42:16 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:42:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:16 INFO - 'USER': 'cltbld', 07:42:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:16 INFO - 'XPC_FLAGS': '0x0', 07:42:16 INFO - 'XPC_SERVICE_NAME': '0', 07:42:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42: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)) 07:42: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)) 07:42: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)) 07:42: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)) 07:42: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)) 07:42: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)) 07:42: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)) 07:42: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)) 07:42: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)) 07:42: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)) 07:42: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)) 07:42:16 INFO - Cleaning up... 07:42:16 INFO - Return code: 0 07:42:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42: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 0x107690b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107693768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09a58cf60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073a1d30>, '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 0x107354db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107395be8>, '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.ijTvTei6hR/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.L1KKwGjwWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42: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 07:42: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 07:42:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijTvTei6hR/Render', 07:42:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:16 INFO - 'HOME': '/Users/cltbld', 07:42:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:16 INFO - 'LOGNAME': 'cltbld', 07:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:16 INFO - 'MOZ_NO_REMOTE': '1', 07:42:16 INFO - 'NO_EM_RESTART': '1', 07:42:16 INFO - 'PAGER': '/bin/cat', 07:42:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:16 INFO - 'PWD': '/builds/slave/test', 07:42:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:16 INFO - 'SHELL': '/bin/bash', 07:42:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1KKwGjwWB/Listeners', 07:42:16 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:42:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:16 INFO - 'USER': 'cltbld', 07:42:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:16 INFO - 'XPC_FLAGS': '0x0', 07:42:16 INFO - 'XPC_SERVICE_NAME': '0', 07:42:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:42:16 INFO - Cleaning up... 07:42:16 INFO - Return code: 0 07:42:16 INFO - Running post-action listener: _resource_record_post_action 07:42:16 INFO - Running post-action listener: _start_resource_monitoring 07:42:16 INFO - Starting resource monitoring. 07:42:16 INFO - [mozharness: 2017-05-09 14:42:16.942267Z] Finished create-virtualenv step (success) 07:42:16 INFO - [mozharness: 2017-05-09 14:42:16.943167Z] Running install step. 07:42:16 INFO - Running pre-action listener: _resource_record_pre_action 07:42:16 INFO - Running main action method: install 07:42:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:17 INFO - Reading from file tmpfile_stdout 07:42:17 INFO - Detecting whether we're running mozinstall >=1.0... 07:42:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:42:17 INFO - Reading from file tmpfile_stdout 07:42:17 INFO - Output received: 07:42:17 INFO - Usage: mozinstall [options] installer 07:42:17 INFO - Options: 07:42:17 INFO - -h, --help show this help message and exit 07:42:17 INFO - -d DEST, --destination=DEST 07:42:17 INFO - Directory to install application into. [default: 07:42:17 INFO - "/builds/slave/test"] 07:42:17 INFO - --app=APP Application being installed. [default: firefox] 07:42:17 INFO - mkdir: /builds/slave/test/build/application 07:42:17 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'] 07:42:17 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 07:42:36 INFO - Reading from file tmpfile_stdout 07:42:36 INFO - Output received: 07:42:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:42:36 INFO - Running post-action listener: _resource_record_post_action 07:42:36 INFO - [mozharness: 2017-05-09 14:42:36.996526Z] Finished install step (success) 07:42:36 INFO - [mozharness: 2017-05-09 14:42:36.996667Z] Running run-tests step. 07:42:36 INFO - Running pre-action listener: _resource_record_pre_action 07:42:36 INFO - Running main action method: run_tests 07:42:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:42:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:42:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:42:37 INFO - 2017-05-09 07:42:37.011 screenresolution[1621:7544] starting screenresolution argv=screenresolution get 07:42:37 INFO - 2017-05-09 07:42:37.013 screenresolution[1621:7544] Display 0: 1600x1200x32@60 07:42:37 INFO - 2017-05-09 07:42:37.019 screenresolution[1622:7547] starting screenresolution argv=screenresolution list 07:42:37 INFO - Available Modes on Display 0 07:42:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:42:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:42:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:42:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:42:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:42:37 INFO - Intel Iris: 07:42:37 INFO - Chipset Model: Intel Iris 07:42:37 INFO - Type: GPU 07:42:37 INFO - Bus: Built-In 07:42:37 INFO - VRAM (Dynamic, Max): 1536 MB 07:42:37 INFO - Vendor: Intel (0x8086) 07:42:37 INFO - Device ID: 0x0a2e 07:42:37 INFO - Revision ID: 0x0009 07:42:37 INFO - Displays: 07:42:37 INFO - Display: 07:42:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:42:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:42:37 INFO - Display Serial Number: 1600x1200 60 07:42:37 INFO - Main Display: Yes 07:42:37 INFO - Mirror: Off 07:42:37 INFO - Online: Yes 07:42:37 INFO - Rotation: Supported 07:42:37 INFO - Return code: 0 07:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:42:37 INFO - Python 2.7.3 07:42:37 INFO - Return code: 0 07:42:37 INFO - grabbing minidump binary from tooltool 07:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:37 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 0x1073a1d30>, '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 0x107354db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107395be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:42:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:42:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:42:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:42:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:42:37 INFO - Return code: 0 07:42:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:42:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:42:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:42:37 INFO - ENV: RUST_BACKTRACE is now 1 07:42:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:42:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:42: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/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:42: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/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/target.crashreporter-symbols.zip --title t-yosemite-r7-0299 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:42:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijTvTei6hR/Render', 07:42:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:37 INFO - 'HOME': '/Users/cltbld', 07:42:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:37 INFO - 'LOGNAME': 'cltbld', 07:42:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:42:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:37 INFO - 'MOZ_NO_REMOTE': '1', 07:42:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:42:37 INFO - 'NO_EM_RESTART': '1', 07:42:37 INFO - 'PAGER': '/bin/cat', 07:42:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:37 INFO - 'PWD': '/builds/slave/test', 07:42:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:42:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:37 INFO - 'RUST_BACKTRACE': '1', 07:42:37 INFO - 'SHELL': '/bin/bash', 07:42:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L1KKwGjwWB/Listeners', 07:42:37 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:42:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:37 INFO - 'USER': 'cltbld', 07:42:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:37 INFO - 'XPC_FLAGS': '0x0', 07:42:37 INFO - 'XPC_SERVICE_NAME': '0', 07:42:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42: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/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:42:37 INFO - mozversion application_buildid: 20170509052116 07:42:37 INFO - mozversion application_changeset: b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6 07:42:37 INFO - mozversion application_display_name: Nightly 07:42:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:42:37 INFO - mozversion application_name: Firefox 07:42:37 INFO - mozversion application_remotingname: firefox 07:42:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:42:37 INFO - mozversion application_vendor: Mozilla 07:42:37 INFO - mozversion application_version: 55.0a1 07:42:37 INFO - mozversion platform_buildid: 20170509052116 07:42:37 INFO - mozversion platform_changeset: b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6 07:42:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:42:37 INFO - mozversion platform_version: 55.0a1 07:42:37 INFO - using testdate: 1494340957 07:42:37 INFO - actual date: 1494340957 07:42:37 INFO - starting webserver on 'localhost:49240' 07:42:37 INFO - SUITE-START | Running 2 tests 07:42:37 INFO - TEST-START | dromaeo_css 07:42:37 INFO - operating with platform_type : mac_ 07:42:37 INFO - Initialising browser for dromaeo_css test... 07:42:37 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpezsuw7/profile http://localhost:49240/getInfo.html) 07:42:40 INFO - PID 1632 | 2017-05-09 07:42:40.452 plugin-container[1634:7726] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x983b, name = 'com.apple.tsm.portname' 07:42:40 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:42:40 INFO - PID 1632 | 2017-05-09 07:42:40.454 plugin-container[1634:7726] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4927, name = 'com.apple.CFPasteboardClient' 07:42:40 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:42:40 INFO - PID 1632 | 2017-05-09 07:42:40.454 plugin-container[1634:7726] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:42:40 INFO - PID 1632 | __metrics Screen width/height:1600/1200 07:42:40 INFO - PID 1632 | colorDepth:24 07:42:40 INFO - PID 1632 | Browser inner width/height: 1024/691 07:42:40 INFO - PID 1632 | __metrics 07:42:41 INFO - PID 1632 | 2017-05-09 07:42:41.111 plugin-container[1635:7780] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9443, name = 'com.apple.tsm.portname' 07:42:41 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:42:41 INFO - PID 1632 | 2017-05-09 07:42:41.111 plugin-container[1635:7780] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 07:42:41 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:42:41 INFO - PID 1632 | 2017-05-09 07:42:41.112 plugin-container[1635:7780] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:42:41 INFO - TEST-INFO | 1632: exit 0 07:42:41 INFO - Browser initialized. 07:42:41 INFO - Running cycle 1/1 for dromaeo_css test... 07:42:41 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpezsuw7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:43 INFO - PID 1636 | 2017-05-09 07:42:43.992 plugin-container[1637:7892] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 07:42:43 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:42:43 INFO - PID 1636 | 2017-05-09 07:42:43.993 plugin-container[1637:7892] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 07:42:43 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:42:43 INFO - PID 1636 | 2017-05-09 07:42:43.993 plugin-container[1637:7892] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:42:44 INFO - PID 1636 | 2017-05-09 07:42:44.482 plugin-container[1638:7934] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 07:42:44 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:42:44 INFO - PID 1636 | 2017-05-09 07:42:44.483 plugin-container[1638:7934] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 07:42:44 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:42:44 INFO - PID 1636 | 2017-05-09 07:42:44.483 plugin-container[1638:7934] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:42:53 INFO - PID 1636 | RSS: Main: 232329216 07:42:53 INFO - PID 1636 | 07:45:57 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 07:45:59 INFO - PID 1636 | RSS: Main: 249876480 07:45:59 INFO - PID 1636 | 07:49:01 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 07:49:01 INFO - PID 1636 | RSS: Main: 259461120 07:49:01 INFO - PID 1636 | 07:52:03 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 07:52:03 INFO - PID 1636 | RSS: Main: 269774848 07:52:03 INFO - PID 1636 | 07:55:05 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 07:55:06 INFO - PID 1636 | RSS: Main: 262070272 07:55:06 INFO - PID 1636 | 07:58:09 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 07:58:09 INFO - PID 1636 | RSS: Main: 269283328 07:58:09 INFO - PID 1636 | 08:01:11 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 08:01:11 INFO - PID 1636 | RSS: Main: 267980800 08:01:11 INFO - PID 1636 | 08:01:11 INFO - PID 1636 | __start_tp_report 08:01:11 INFO - PID 1636 | _x_x_mozilla_page_load 08:01:11 INFO - PID 1636 | _x_x_mozilla_page_load_details 08:01:11 INFO - PID 1636 | |i|pagename|runs| 08:01:11 INFO - PID 1636 | |0;dojo.html;3643.7267204959617;3648.525691660084;3671.9816400917994;3673.871414500493;3688.0964163779877;4724.645651576128;5643.633163844353;6026.704258584404;6083.756649734005;6179.196704428418;6235.282942461618;6282;6336.619802811834;6346.524010699193;6362.650054247015;5391.137418013119;5474.343078830546;5530.170474428827;5532.170174473841;5633.521150702195;5642.858928526779;5652.886942261152;5653.208550802891;5659.547236221113;5663.8584035399035;5439.428859969726;5522.972385138089;5553.12549705741;5559.499645031926;5573.554115670777;5561.360443549003;5586.106223004341;5604.523615492688;5620.522255608278;5630.15547667849;5462.016836969344;5516.862078448031;5525;5532.948739739437;5568.1647752837;6133.539984501181;6188.535859810532;6273;6354.459870910978;6379.744810207632;6703.363180497845;6792.898106528406;6794.796156115324;6812.965935170342;6814.250432452426;6909.7581584644795;6915.446764258847;6922.2731613180895;6940.72237110515;6943;6274.529410294246;6307.085472606446;6307.905381419282;6363.936360636427;6381.521385895983;6885.345892140239;6987;7044.22513523512;7062.0466237057335;7090.220075791659;5675.971620141873;6455.4512866406885;6529.608223506605;6612.07430959666;6730.0241464988285;6844.1444819397575;6853.451723862079;6904.102466679299;6913.89629155553;6927.445804335641;6560.934390656128;6803.489738269551;6804.149481314836;6815.795526134224;6835.111435513351;6638.302978187317;6643.966780166165;6671.699773510204;6783.18601767791;6799.184097908283;5428.348598168166;5430.321209848769;5437.102878025161;5439.401665816757;5453.15476101205;4429.003474218275;4628.930566041512;4803.207470767354;4803.519648035239;4831.323614693945;6288.654124023131;6293.590916590407;6347.492200623939;6447.323031081763;6492.967535162388;6943.652817359111;6949.44404447643;6969.930300697029;6991.370776630128;6997.300269973064;6473.255575608865;6498.155239818888;6510.967445162744;6520.967395163088;6527.184101987252;5885.882282354414;5954.255718035246;5974.2233509643465;6039.78860739872;6108.053251745987;6137.631742095488;6912.654367281616;7015.894761578683;7046;7153.177384600837;5627.971860140673;5768;6971.58170509771;6988.510804243858;6991.895121573282;7012.4390048796995;7105.751298704728;7106.147262328554;7138.571685698875;7141.64291785419;5860.267466566679;6575.2767195607485;6691.799246022627;6726.730930762715;6829.590224586541;6785.626790526569;6946.722131114699;6961.095057642474;6964.303569642995;6975.8604827902145;6499.2200935887995;6573.80278591643;6580.539362244597;6626.469882409299;6652.800415987334;6420.518461115528;6440.677966101583;6445.709943052668;6448.25845027809;6455.515836312202;6213.2233470816145;6355.713992870239;6359.7456101755415;6437.356264373525;6500.414962653384;6639.502037347315;6670.199576050905;6670.999350097524;6715.059891615276;6717;6498.545101842826;6520.445762110274;6522.05430212626;6526.804195874131;6557.540972131905 08:01:11 INFO - PID 1636 | |1;ext.html;805.3557154276579;833.1044127562868;1037.5953378182505;1108.7061928588926;1137.0562433180462;37494.625053749456;38362.61637383625;38445.807770961175;38446.42330365047;38592.80703596482;31518.896838610654;37844;37905.86282411532;38185.42721859174;38310.8084459578;7790.999999999985;7946.801329966739;7963.681452741884;8268.049174344967;8541.487510749344;8511;8613.655453781841;8614.095519970408;8614.44006139602;8620.836187114723;8512.914870851275;8573.571321433934;8599.140085991414;8625.396222264444;8639.654413823471;8479.2792612628;8573;8617.35369847264;8617.95691021544;8670.393072484929;8271.296939760128;8286;8363.58182090893;8381.95809020951;8387.790305242357;37023.18698569196;37132;37134.25731485355;37307.81346093252;37483;3567.4292113261754;3587.964120358789;3608.873689420884;3611.6930060944587;3615.132368231632;30644.38711225763;30664.38671226563;30712.925047623226;30740.846295768602;30752.38495230083;3098.891538796154;3163.1617621330365;3179.82510961897;3183.5383869338816;3201.807891526516;296608;299252;300634;300733.49633251695;302384;34634.48048279278;45927.622171334915;46593.534064659594;49057.75471122622;49562.50437495651;40745;41187;50406.243906341435;51013.744931275105;51069.489305107214;11669;11775.88224117765;14008.649783755283;14209.218492982778;14295;9874.308798384043;10557.788844223227;11128.610498632508;11370.147238957112;11538.442310288172;12094.39528023613;13699.726005479835;13844.792328115087;13888.722225555432;13932.955028372913;5202.973985130126;5935.872184284972;5964.85087872798;5999.340072592011;6056.303525094582;894.5080205886736;1041.6874937518714;1046.398320965448;1058.2909450668071;1091.9454027298602;19761.308354207533;22451.550968980857;22725.886370568373;25076.623850642256;25235;1152.4180288954024;1152.458344578047;1185.9110566707532;1188.5958774016876;1199.8020326646006;10333.689989300334;12269.509219631114;12325.75348493043;12689.555865544662;12890.80663790044;336359;336854.6314536872;337517;338598;338917.3054134763;56477;56767.71616141893;56813.715931420906;56875.43124568784;61639.38360616426;1526.809148856393;1532.9156896370807;1568.6941046496052;1569.0977687829543;1585.1677869118805;24689.753102468745;30494.695053049185;30562.694373055983;30963;31161.90933317323;41947.1610567793;45452;48376;51313.48686513087;53223;230131.84934075223;232092;275848;278566.60716697096;279300;34056;35052;35294.47058294179;36062;36069.27861442704;42821.57178428176;43625.78187109044;43677.344839826794;45053.87365315893;45096.77451612852;29599.408011840074;30143.698563014965;30576.929807456632;30665.846670766503;30802.69197308088;30708;30745.538816917317;31111.355534779796;31457.741690333045;31533;37250.8137459311;37325.44011839879;37374.439383409815;37424.6257537432;37480.81259593685;26047.479050419264;29312.853435732686;31950.68049319477;32158.51762223615;32205;21500;23155.768442315362;24836.875815620806;24979.625305620793;25355.85898634529 08:01:11 INFO - PID 1636 | |2;jquery.html;434.20757118259183;436.256183207631;444.19378827428216;450.9458864936207;465.58795466012566;21654.242101526448;22198.66701999467;22437.32688019358;22545.436364090885;22801.885990570066;19423.83456992578;22962.88518557405;23148.30555083346;23284.76715232847;23495.647565286534;4467.771492311362;5932.495737862276;6190.41191086846;6190.504759619243;6192.845178870519;5993.430624090726;6108.725107370179;6140.9385906140815;6143.692815359236;6149.477294429978;5828.6502809831545;6018.8495287617725;6093;6099.054646529795;6106.969465152668;6012.7294271757655;6096.634201947897;6103.176071230416;6108.81673549792;6125.234345706786;5350.91973620396;5384.946150538483;5400.189971504266;5427.565794736412;5437.456254374571;27511.17466476009;27563;27630.861845690844;27801.721982780116;28015;2292.1748170658548;2331.6619090231993;2347.178487529351;2348.518553696488;2354.81161507079;17763.733543996852;18025.459236222934;18087.276508939627;18088.909555452137;18402.815971840246;2146.5170336674278;2174.402039439151;2207.746109197447;2212.4911270407897;2226.065052677879;135526;135972.960405594;136097.3195134028;137156;138416;12641.620751377473;12938.288394138224;13098.017648676387;13109.27898965547;13222.867771322357;12412.875871241173;16733.995960242424;17094;17115.14424278781;17138;8822.602982865787;9142.217267632748;9143.908560914439;9241.445513269226;9257.120573545637;8596.097409772008;8612.267957223707;8618.482891026559;8792.956035219782;8793.340499462565;8015.879761803578;8133.389995750224;8152.918470815334;8168.469049511763;8222.917770822334;2166.068590506066;2174.5868285025795;2181.825453963679;2182.127149140357;2200.9779902201094;991.9008099190168;995.5669283861398;1013.8225810483136;1050.112654806687;1052.1267348101057;20971.58056838855;21930.561388772134;22334.21830235934;22388.664170037464;22399.88800055989;1031.242037102729;1046.581367453025;1063.8563793887881;1072.7532667486366;1079.0666073846066;9637.469939153274;9970.50147492637;11047.779044419067;11549.36478493691;11555.133364997659;488357;529590;571014;572346;583357;131119;135583.32208338895;136611;137188;139747;1187.2638963842473;1199.232491205629;1252.3362617812575;1258.3330834657645;1277.4251586785983;20805.89597052005;22692;22860.771392285864;22909.19817806369;22914;59232.1115183264;59381.40618593759;59833.10250346161;60164.69917650559;60646.69676651765;54958.45041549693;59455;75079;77897;78805;7928;8918.777030574287;9158.496282704515;9188.724338269863;9367.250619950524;14098.577042688736;14195.64510887236;14261.572152835432;14449.133052016912;14499.275036248357;11682.94158529202;11863.228890122115;12030.037596992395;12112.394380280775;12142.210756300812;10366.481675916024;10842.891571084188;11029.062529685067;11385.430728463709;11693.239939403911;10816.810150883239;11706.824397634213;12107.152499325315;12370.13409061393;12526.749465010831;8913.153250441197;9057.320700947586;9113.77215569616;9117;9149.993500715049;11730.061595072544;11844.644660660195;12100.334481603244;12151.331676757864;12414.441350139085 08:01:11 INFO - PID 1636 | |3;mootools.html;1197.8323034775133;1379.6206043338082;1382.6405134664983;1444.894655588475;1447.3125265498886;9678.709638710832;11201.551937922484;11637.010854077404;11767.058635309177;12052.276863388202;10413.271071025032;11587.073034157269;11692;11772.175947683665;11776.293422394663;2474.824458382263;2520.521100990815;2524.3436706456364;2527.5324065047935;2532.5821239495463;2450.803935685141;2492.962605560918;2500.712418071918;2507.260358194337;2511.183865243794;2056.640087984604;2446.8164887633498;2485.8632775197357;2516.697996240454;2520.1305549585363;2447.6328550717444;2466.5436894174545;2506.0101260002198;2508.5108403861254;2520.155747824481;2419.576574099543;2476.4304210031614;2492.439201179738;2494.725580186178;2549.68128983877;9985;11665.825012624817;11796;11876.465559049864;11906.940465297705;6566.409023187936;6781.38967492928;6811.284815094394;6825.897611535831;6842.349976752201;4017.799110044486;4366.432363792718;4423.424954755861;4425.690201685883;4444.866654000353;1215.7264615461538;1216.22769541341;1240.962771116868;1255.805350170725;1258;13405.932970335183;15585.29866156037;16629.50111496645;16727.498175054767;16765.7485137723;5516.448355164452;5639.802606908821;5653.378128405872;5782.074868021181;5800;11798.292102473879;11863.16957812962;11871.109666775026;11877.465514051715;11877.465514051715;5959.225300710967;6286.465650419766;6578.671066446658;6599.208095028627;6611.206655201407;5698.772049117989;5896.3219229788265;6221.097940798559;6251.593646412968;6292.874142517124;4346.673999450054;4423.225935461346;4444.755538445352;4465.441819772528;4472.575105364985;1126.4987080748988;1245.735578387937;1256.3969294738577;1274.0762946863636;1286.4468278640088;789.7314912929631;792.1661353965667;813.4102775487725;820.1429506166071;848.7538613802052;6144.293406258248;6153.569250152446;6321.778737744157;6362.84092897672;6421.29365769765;556.2157358125024;587.0782870892742;597.4115496236204;604.4197570332442;619.2228752915153;3918.6081391861157;4230.217409779139;4288.678349123766;4296.226679197712;4378.387025816324;14627.26863656813;15080.698386032218;15214.315355809014;15225.543233703007;15276.312565934559;14939;14987.700245995236;15346.462873799363;15384.076955382712;15402.922985385225;6228.719707613078;7609.885851712229;8389.161083891684;8829.381943264038;8854.601542930584;6354.872902541831;7154.892676609751;7169.928300716926;7243.855122897618;7255.238199988925;12626.494940202288;12996.415161317953;13033.15284506504;13046.739065218453;13094.934525327313;13467;13675.863241367459;13726.45094196221;13981.370838312097;14133.434662613381;9254.398464099811;9551.522423878918;9551.856722149034;9556.952215239158;9573.042695730372;10534.52594633228;10826.783464330827;10832.891671083189;10918.07196388316;10932.234743567873;8312.293455056146;9552.665656701982;9644.421334719938;9689.757756056155;9782.972787857172;9391.577379017825;9415.670451534163;9429.622815087594;9522.857157142787;9552.044795520393;8250.958745206235;8314.376421768271;8325;8342.332613391036;8368.665253389796;6135.754569817157;6263;6263.937360626335;6279.183706118175;6322.36776322364;6072.635641861502;6269.12232287471;6351.491880649629;6380.425761681286;6387.776427825004 08:01:11 INFO - PID 1636 | |4;prototype.html;345.49212657393633;384.819135006547;408.2875382457612;409.8811344710034;411.9691023173262;6262.185915830947;6275.748970041199;6460.515461340395;6494.935050649492;6534.346565343463;6125.877482450348;6206.989610039139;6245.56281060326;6246.657503436211;6258.374162583739;4532.161550113223;4562.498125206224;4571.47428045774;4574.81700731972;4593.42582177227;4394.934075988863;4518.186726389248;4535.7278563286145;4568.47462541807;4583.175028494869;3606.531150950386;4383.320585309282;4479.454588167077;4486.573775491323;4499.730016199039;4469.575390337913;4487.775611219442;4490.8877278067985;4511.030128522383;4512.796924138422;3747.4940882980995;3854.2291541691493;3862.864799732024;3866.8066596670055;3870.3420418528917;4457.398251236074;5044.672096313728;5841.707914604252;6174.783882564134;6222.377762223787;5450.645708029005;5451.836444906659;5466;5479.863003424906;5545.72271386429;6455.870882582369;6655.304601636345;6662.800115996528;6714.093597364391;6730.427913627299;3762.473253744478;4184.476940382452;4361.105973275471;4428.822847086113;4443.600075993144;5863.153166641721;6641.601503909733;6730.427913627347;7094.219635840053;7157.248488908694;3976.284268831638;4459.509453960061;4469.664775141878;4470.9105817883465;4471.217536931024;3513.683768460851;4576.382188404589;4576.565226303496;4585.9541404585525;4675.251959686434;4693.83571575;5199.63602547818;5309.044372012998;5365.919511207335;5414.593905457106;6396.9360306397275;6575.046618240328;6757;6800.829979250559;6860.931390686029;1334.9532766353132;1551.4880089570415;1551.67414842882;1552.6351307442742;1555.572217640158;981.5730157381562;1010.7422607235255;1011.3780025284398;1019.56158851693;1030.160419258302;6469.805905822833;6478.242619280806;6490.4807615390655;6493.772717954849;6548.967255163694;6152.446279834747;6852.486063545254;6928.972110294714;6998.405135563432;7081.539699919489;5189.273501709764;6400.551961362753;6437.806865794034;6452.806415807533;6489.825908320766;3324.351751408452;3552.4848896909803;3672.2288319452678;3692.390755525362;3707.240015796809;6117.694115294217;7158.033665455201;7208.423326134001;7285.854282914418;7395.151212196951;6431.488600178955;6463.48292136628;7021.403180729695;7180.748673796392;7231.349178573849;6234.937650623527;6751.324867513307;6812.046313516112;7280.635968201463;7316.597587132653;6433.195850518685;6522.412982831568;6803.285655006153;7027.613481258375;7107.50247482692;6871.656417179221;6940.444764418935;6947.270536593584;6985.650717464208;7002.9691389496475;5428.728563571726;6826.829329266808;7114.288571142844;7114.964425177841;7315.817104572216;4224.394730002579;4454.309582014793;4466.754328511963;4485.380058539709;4493.820247190076;6363.659078983571;6575.2575567475615;6990;7023.403010744144;7078.716851325889;6622.741679080959;6750.493712971449;6808.421284190899;6855.520113592001;6864.4165245954655;6576.2766095730385;6791.5585486945165;6805.319468053155;6861.416779573592;6863.72445208081;5840.620359676607;5933.940660593339;6126;6614.801555953329;6729.629870357177;6497.9025314619375;6716.328367163244;6776.934643493947;6791.388775010273;6824.658767061726;6272.372762723691;6273.937260627518;6446.548741588043;6655.267920528641;6664.933350666432 08:01:11 INFO - PID 1636 | |5;yui.html;755.6675062972291;829.2329595124515;837.6774941647463;858.7848194804352;872.0189786490198;13906.374213160407;14415.351309191085;15694.136822474758;16078.27647755851;16180.433684821033;12870.871291287085;13070.954323654109;16969.660606787857;16977.2360243789;16996.320147194096;832.4381042796089;980.3480685344256;986.7138529826377;1001.0590045357377;1003.8795344558627;823.3577809308719;974.8830140383164;993.5975929748463;997.5710444508858;999.7350702063959;1046.2310202001522;1048.1038711901328;1048.5229220704562;1051.0277992856616;1053.520648105114;986.5116767200246;1009.5305682857506;1024.4212020208595;1034.6430481483876;1036.984445233322;756.5800980455845;759.4456047085658;759.502525845572;759.5101159751985;761.8857171424276;16649.4172703956;16789.83210167895;16814.579635509086;16824.915875420666;17099.74350384745;16936.745948810778;17195.82804171955;17517.824821751874;17568.648627027516;17759;13903.096298740651;14124.50564230247;14140.92929535356;14259.144451332953;14269.714605707932;3469.340825243221;3474.982625086858;3494.2836718472654;3499.6325385834375;3501.7548771586;119409;119499;120859;121155;121473.39263303715;12002.819957700467;12946.899513541266;13037.76141266578;13239.66900827487;13309.933450332686;24763.380915477257;25339;25719.485610288062;26483.602745958826;26560.46879062408;7650.38796896247;7856.7250146244605;7887.171846956102;7895.092064412551;7931.960340198262;3900.3564411871725;4024.5371782245415;4028.1742242840146;4037.6164264394833;4037.899052523652;4232.470941132358;4274.418465167845;4401.757903315349;4407.625351845065;4460.888477788081;893.7229458867772;909.6582540752337;947.2422062350092;951.6336210558985;971.1114330387758;648.0764910003227;665.7170702451439;668.5754545863412;669.5413641655482;683.565935630868;10986.835197472044;11722;12039.578614748441;12123.75752484963;12238.877611223774;639.3223183425583;649.5615459564775;653.1443808610735;660.1550015979553;677.403884581575;4934.728589927517;5010;5420.620556561082;5561.916571251434;5662.886742265214;108360;109917;110534;112700;116152.41923790496;87599;97354;98088.01911980931;99033;100323;79397.60301198457;80887.19112808914;81444.18555814485;81639.18360816316;81789;12070;12728.74542509163;12774.297413642338;12792;12863.29251891155;38707;40294.742498345404;41055.58944410637;41472.37791433191;43215;37813.62186378211;51612.709682258246;52247.47752522426;52461;52652.736736316074;15546.611334716723;15898.602534936257;16214.51356459308;16332.755008675116;16352.509424717278;17210.39763608268;17763.911180444014;17809.910950445166;18056.638867222846;18108.818911810715;16126.67746645084;16170.434034808724;16473.423430179886;16562.420315288906;16772.1613919306;16073.276702548179;16453.753193701865;16530.66938661244;16634.667306654042;16664.583385414975;15028;15637.84362156364;15717;16373.508794736177;16589.262771643025;11293;11382.430878456209;11830.408479575815;11913.642590722293;11967.76064478723;10423.895761042293;11997.700057498283;13276.468941242241;13288.734225315246;13312.334383280991 08:01:11 INFO - PID 1636 | __end_tp_report 08:01:11 INFO - PID 1636 | __start_cc_report 08:01:11 INFO - PID 1636 | _x_x_mozilla_cycle_collect,404 08:01:11 INFO - PID 1636 | __end_cc_report 08:01:11 INFO - PID 1636 | __startTimestamp1494342071755__endTimestamp 08:01:11 INFO - PID 1636 | 08:01:11 INFO - PID 1636 | ------- Summary: start ------- 08:01:11 INFO - PID 1636 | Number of tests: 6 08:01:11 INFO - PID 1636 | 08:01:11 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:6244.87 Median:6455.45 stddev:752.61 (11.7%) stddev-sans-first:726.73 08:01:11 INFO - PID 1636 | Values: 3643.7 3648.5 3672.0 3673.9 3688.1 4724.6 5643.6 6026.7 6083.8 6179.2 6235.3 6282.0 6336.6 6346.5 6362.7 5391.1 5474.3 5530.2 5532.2 5633.5 5642.9 5652.9 5653.2 5659.5 5663.9 5439.4 5523.0 5553.1 5559.5 5573.6 5561.4 5586.1 5604.5 5620.5 5630.2 5462.0 5516.9 5525.0 5532.9 5568.2 6133.5 6188.5 6273.0 6354.5 6379.7 6703.4 6792.9 6794.8 6813.0 6814.3 6909.8 6915.4 6922.3 6940.7 6943.0 6274.5 6307.1 6307.9 6363.9 6381.5 6885.3 6987.0 7044.2 7062.0 7090.2 5676.0 6455.5 6529.6 6612.1 6730.0 6844.1 6853.5 6904.1 6913.9 6927.4 6560.9 6803.5 6804.1 6815.8 6835.1 6638.3 6644.0 6671.7 6783.2 6799.2 5428.3 5430.3 5437.1 5439.4 5453.2 4429.0 4628.9 4803.2 4803.5 4831.3 6288.7 6293.6 6347.5 6447.3 6493.0 6943.7 6949.4 6969.9 6991.4 6997.3 6473.3 6498.2 6511.0 6521.0 6527.2 5885.9 5954.3 5974.2 6039.8 6108.1 6137.6 6912.7 7015.9 7046.0 7153.2 5628.0 5768.0 6971.6 6988.5 6991.9 7012.4 7105.8 7106.1 7138.6 7141.6 5860.3 6575.3 6691.8 6726.7 6829.6 6785.6 6946.7 6961.1 6964.3 6975.9 6499.2 6573.8 6580.5 6626.5 6652.8 6420.5 6440.7 6445.7 6448.3 6455.5 6213.2 6355.7 6359.7 6437.4 6500.4 6639.5 6670.2 6671.0 6715.1 6717.0 6498.5 6520.4 6522.1 6526.8 6557.5 08:01:11 INFO - PID 1636 | 08:01:11 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:45329.95 Median:338757.65 stddev:78966.17 (23.3%) stddev-sans-first:79116.93 08:01:11 INFO - PID 1636 | Values: 805.4 833.1 1037.6 1108.7 1137.1 37494.6 38362.6 38445.8 38446.4 38592.8 31518.9 37844.0 37905.9 38185.4 38310.8 7791.0 7946.8 7963.7 8268.0 8541.5 8511.0 8613.7 8614.1 8614.4 8620.8 8512.9 8573.6 8599.1 8625.4 8639.7 8479.3 8573.0 8617.4 8618.0 8670.4 8271.3 8286.0 8363.6 8382.0 8387.8 37023.2 37132.0 37134.3 37307.8 37483.0 3567.4 3588.0 3608.9 3611.7 3615.1 30644.4 30664.4 30712.9 30740.8 30752.4 3098.9 3163.2 3179.8 3183.5 3201.8 296608.0 299252.0 300634.0 300733.5 302384.0 34634.5 45927.6 46593.5 49057.8 49562.5 40745.0 41187.0 50406.2 51013.7 51069.5 11669.0 11775.9 14008.6 14209.2 14295.0 9874.3 10557.8 11128.6 11370.1 11538.4 12094.4 13699.7 13844.8 13888.7 13933.0 5203.0 5935.9 5964.9 5999.3 6056.3 894.5 1041.7 1046.4 1058.3 1091.9 19761.3 22451.6 22725.9 25076.6 25235.0 1152.4 1152.5 1185.9 1188.6 1199.8 10333.7 12269.5 12325.8 12689.6 12890.8 336359.0 336854.6 337517.0 338598.0 338917.3 56477.0 56767.7 56813.7 56875.4 61639.4 1526.8 1532.9 1568.7 1569.1 1585.2 24689.8 30494.7 30562.7 30963.0 31161.9 41947.2 45452.0 48376.0 51313.5 53223.0 230131.8 232092.0 275848.0 278566.6 279300.0 34056.0 35052.0 35294.5 36062.0 36069.3 42821.6 43625.8 43677.3 45053.9 45096.8 29599.4 30143.7 30576.9 30665.8 30802.7 30708.0 30745.5 31111.4 31457.7 31533.0 37250.8 37325.4 37374.4 37424.6 37480.8 26047.5 29312.9 31950.7 32158.5 32205.0 21500.0 23155.8 24836.9 24979.6 25355.9 08:01:11 INFO - PID 1636 | 08:01:11 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:35296.38 Median:22911.60 stddev:92809.60 (405.1%) stddev-sans-first:93033.04 08:01:11 INFO - PID 1636 | Values: 434.2 436.3 444.2 450.9 465.6 21654.2 22198.7 22437.3 22545.4 22801.9 19423.8 22962.9 23148.3 23284.8 23495.6 4467.8 5932.5 6190.4 6190.5 6192.8 5993.4 6108.7 6140.9 6143.7 6149.5 5828.7 6018.8 6093.0 6099.1 6107.0 6012.7 6096.6 6103.2 6108.8 6125.2 5350.9 5384.9 5400.2 5427.6 5437.5 27511.2 27563.0 27630.9 27801.7 28015.0 2292.2 2331.7 2347.2 2348.5 2354.8 17763.7 18025.5 18087.3 18088.9 18402.8 2146.5 2174.4 2207.7 2212.5 2226.1 135526.0 135973.0 136097.3 137156.0 138416.0 12641.6 12938.3 13098.0 13109.3 13222.9 12412.9 16734.0 17094.0 17115.1 17138.0 8822.6 9142.2 9143.9 9241.4 9257.1 8596.1 8612.3 8618.5 8793.0 8793.3 8015.9 8133.4 8152.9 8168.5 8222.9 2166.1 2174.6 2181.8 2182.1 2201.0 991.9 995.6 1013.8 1050.1 1052.1 20971.6 21930.6 22334.2 22388.7 22399.9 1031.2 1046.6 1063.9 1072.8 1079.1 9637.5 9970.5 11047.8 11549.4 11555.1 488357.0 529590.0 571014.0 572346.0 583357.0 131119.0 135583.3 136611.0 137188.0 139747.0 1187.3 1199.2 1252.3 1258.3 1277.4 20805.9 22692.0 22860.8 22909.2 22914.0 59232.1 59381.4 59833.1 60164.7 60646.7 54958.5 59455.0 75079.0 77897.0 78805.0 7928.0 8918.8 9158.5 9188.7 9367.3 14098.6 14195.6 14261.6 14449.1 14499.3 11682.9 11863.2 12030.0 12112.4 12142.2 10366.5 10842.9 11029.1 11385.4 11693.2 10816.8 11706.8 12107.2 12370.1 12526.7 8913.2 9057.3 9113.8 9117.0 9150.0 11730.1 11844.6 12100.3 12151.3 12414.4 08:01:11 INFO - PID 1636 | 08:01:11 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:7104.93 Median:4259.45 stddev:4482.51 (105.2%) stddev-sans-first:4473.10 08:01:11 INFO - PID 1636 | Values: 1197.8 1379.6 1382.6 1444.9 1447.3 9678.7 11201.6 11637.0 11767.1 12052.3 10413.3 11587.1 11692.0 11772.2 11776.3 2474.8 2520.5 2524.3 2527.5 2532.6 2450.8 2493.0 2500.7 2507.3 2511.2 2056.6 2446.8 2485.9 2516.7 2520.1 2447.6 2466.5 2506.0 2508.5 2520.2 2419.6 2476.4 2492.4 2494.7 2549.7 9985.0 11665.8 11796.0 11876.5 11906.9 6566.4 6781.4 6811.3 6825.9 6842.3 4017.8 4366.4 4423.4 4425.7 4444.9 1215.7 1216.2 1241.0 1255.8 1258.0 13405.9 15585.3 16629.5 16727.5 16765.7 5516.4 5639.8 5653.4 5782.1 5800.0 11798.3 11863.2 11871.1 11877.5 11877.5 5959.2 6286.5 6578.7 6599.2 6611.2 5698.8 5896.3 6221.1 6251.6 6292.9 4346.7 4423.2 4444.8 4465.4 4472.6 1126.5 1245.7 1256.4 1274.1 1286.4 789.7 792.2 813.4 820.1 848.8 6144.3 6153.6 6321.8 6362.8 6421.3 556.2 587.1 597.4 604.4 619.2 3918.6 4230.2 4288.7 4296.2 4378.4 14627.3 15080.7 15214.3 15225.5 15276.3 14939.0 14987.7 15346.5 15384.1 15402.9 6228.7 7609.9 8389.2 8829.4 8854.6 6354.9 7154.9 7169.9 7243.9 7255.2 12626.5 12996.4 13033.2 13046.7 13094.9 13467.0 13675.9 13726.5 13981.4 14133.4 9254.4 9551.5 9551.9 9557.0 9573.0 10534.5 10826.8 10832.9 10918.1 10932.2 8312.3 9552.7 9644.4 9689.8 9783.0 9391.6 9415.7 9429.6 9522.9 9552.0 8251.0 8314.4 8325.0 8342.3 8368.7 6135.8 6263.0 6263.9 6279.2 6322.4 6072.6 6269.1 6351.5 6380.4 6387.8 08:01:11 INFO - PID 1636 | 08:01:11 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5418.18 Median:6246.11 stddev:1744.83 (27.9%) stddev-sans-first:1707.68 08:01:11 INFO - PID 1636 | Values: 345.5 384.8 408.3 409.9 412.0 6262.2 6275.7 6460.5 6494.9 6534.3 6125.9 6207.0 6245.6 6246.7 6258.4 4532.2 4562.5 4571.5 4574.8 4593.4 4394.9 4518.2 4535.7 4568.5 4583.2 3606.5 4383.3 4479.5 4486.6 4499.7 4469.6 4487.8 4490.9 4511.0 4512.8 3747.5 3854.2 3862.9 3866.8 3870.3 4457.4 5044.7 5841.7 6174.8 6222.4 5450.6 5451.8 5466.0 5479.9 5545.7 6455.9 6655.3 6662.8 6714.1 6730.4 3762.5 4184.5 4361.1 4428.8 4443.6 5863.2 6641.6 6730.4 7094.2 7157.2 3976.3 4459.5 4469.7 4470.9 4471.2 3513.7 4576.4 4576.6 4586.0 4675.3 4693.8 5199.6 5309.0 5365.9 5414.6 6396.9 6575.0 6757.0 6800.8 6860.9 1335.0 1551.5 1551.7 1552.6 1555.6 981.6 1010.7 1011.4 1019.6 1030.2 6469.8 6478.2 6490.5 6493.8 6549.0 6152.4 6852.5 6929.0 6998.4 7081.5 5189.3 6400.6 6437.8 6452.8 6489.8 3324.4 3552.5 3672.2 3692.4 3707.2 6117.7 7158.0 7208.4 7285.9 7395.2 6431.5 6463.5 7021.4 7180.7 7231.3 6234.9 6751.3 6812.0 7280.6 7316.6 6433.2 6522.4 6803.3 7027.6 7107.5 6871.7 6940.4 6947.3 6985.7 7003.0 5428.7 6826.8 7114.3 7115.0 7315.8 4224.4 4454.3 4466.8 4485.4 4493.8 6363.7 6575.3 6990.0 7023.4 7078.7 6622.7 6750.5 6808.4 6855.5 6864.4 6576.3 6791.6 6805.3 6861.4 6863.7 5840.6 5933.9 6126.0 6614.8 6729.6 6497.9 6716.3 6776.9 6791.4 6824.7 6272.4 6273.9 6446.5 6655.3 6664.9 08:01:11 INFO - PID 1636 | 08:01:11 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:21710.66 Median:17543.24 stddev:30923.93 (176.3%) stddev-sans-first:30970.65 08:01:11 INFO - PID 1636 | Values: 755.7 829.2 837.7 858.8 872.0 13906.4 14415.4 15694.1 16078.3 16180.4 12870.9 13071.0 16969.7 16977.2 16996.3 832.4 980.3 986.7 1001.1 1003.9 823.4 974.9 993.6 997.6 999.7 1046.2 1048.1 1048.5 1051.0 1053.5 986.5 1009.5 1024.4 1034.6 1037.0 756.6 759.4 759.5 759.5 761.9 16649.4 16789.8 16814.6 16824.9 17099.7 16936.7 17195.8 17517.8 17568.6 17759.0 13903.1 14124.5 14140.9 14259.1 14269.7 3469.3 3475.0 3494.3 3499.6 3501.8 119409.0 119499.0 120859.0 121155.0 121473.4 12002.8 12946.9 13037.8 13239.7 13309.9 24763.4 25339.0 25719.5 26483.6 26560.5 7650.4 7856.7 7887.2 7895.1 7932.0 3900.4 4024.5 4028.2 4037.6 4037.9 4232.5 4274.4 4401.8 4407.6 4460.9 893.7 909.7 947.2 951.6 971.1 648.1 665.7 668.6 669.5 683.6 10986.8 11722.0 12039.6 12123.8 12238.9 639.3 649.6 653.1 660.2 677.4 4934.7 5010.0 5420.6 5561.9 5662.9 108360.0 109917.0 110534.0 112700.0 116152.4 87599.0 97354.0 98088.0 99033.0 100323.0 79397.6 80887.2 81444.2 81639.2 81789.0 12070.0 12728.7 12774.3 12792.0 12863.3 38707.0 40294.7 41055.6 41472.4 43215.0 37813.6 51612.7 52247.5 52461.0 52652.7 15546.6 15898.6 16214.5 16332.8 16352.5 17210.4 17763.9 17809.9 18056.6 18108.8 16126.7 16170.4 16473.4 16562.4 16772.2 16073.3 16453.8 16530.7 16634.7 16664.6 15028.0 15637.8 15717.0 16373.5 16589.3 11293.0 11382.4 11830.4 11913.6 11967.8 10423.9 11997.7 13276.5 13288.7 13312.3 08:01:11 INFO - PID 1636 | -------- Summary: end -------- 08:01:11 INFO - PID 1636 | 08:01:12 INFO - TEST-INFO | 1636: exit 0 08:01:12 INFO - TEST-OK | dromaeo_css | took 1114809ms 08:01:12 INFO - TEST-START | kraken 08:01:12 INFO - operating with platform_type : mac_ 08:01:12 INFO - Initialising browser for kraken test... 08:01:12 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpo2Izz6/profile http://localhost:49240/getInfo.html) 08:01:15 INFO - PID 1649 | 2017-05-09 08:01:15.099 plugin-container[1650:10316] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443f, name = 'com.apple.tsm.portname' 08:01:15 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:01:15 INFO - PID 1649 | 2017-05-09 08:01:15.104 plugin-container[1650:10316] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 08:01:15 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:01:15 INFO - PID 1649 | 2017-05-09 08:01:15.104 plugin-container[1650:10316] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:01:15 INFO - PID 1649 | __metrics Screen width/height:1600/1200 08:01:15 INFO - PID 1649 | colorDepth:24 08:01:15 INFO - PID 1649 | Browser inner width/height: 1024/691 08:01:15 INFO - PID 1649 | __metrics 08:01:15 INFO - PID 1649 | 2017-05-09 08:01:15.709 plugin-container[1651:10374] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x944f, name = 'com.apple.tsm.portname' 08:01:15 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:01:15 INFO - PID 1649 | 2017-05-09 08:01:15.709 plugin-container[1651:10374] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 08:01:15 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:01:15 INFO - PID 1649 | 2017-05-09 08:01:15.709 plugin-container[1651:10374] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:01:16 INFO - TEST-INFO | 1649: exit 0 08:01:16 INFO - Browser initialized. 08:01:16 INFO - Running cycle 1/1 for kraken test... 08:01:16 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpo2Izz6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:18 INFO - PID 1652 | 2017-05-09 08:01:18.942 plugin-container[1653:10474] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9343, name = 'com.apple.tsm.portname' 08:01:18 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:01:18 INFO - PID 1652 | 2017-05-09 08:01:18.942 plugin-container[1653:10474] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9527, name = 'com.apple.CFPasteboardClient' 08:01:18 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:01:18 INFO - PID 1652 | 2017-05-09 08:01:18.942 plugin-container[1653:10474] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:01:19 INFO - PID 1652 | 2017-05-09 08:01:19.451 plugin-container[1654:10516] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4847, name = 'com.apple.tsm.portname' 08:01:19 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:01:19 INFO - PID 1652 | 2017-05-09 08:01:19.451 plugin-container[1654:10516] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x990b, name = 'com.apple.CFPasteboardClient' 08:01:19 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:01:19 INFO - PID 1652 | 2017-05-09 08:01:19.451 plugin-container[1654:10516] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:01:28 INFO - PID 1652 | RSS: Main: 234123264 08:01:28 INFO - PID 1652 | 08:01:31 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 08:01:32 INFO - PID 1652 | RSS: Main: 247164928 08:01:32 INFO - PID 1652 | 08:01:35 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 08:01:35 INFO - PID 1652 | RSS: Main: 255127552 08:01:35 INFO - PID 1652 | 08:01:38 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 08:01:39 INFO - PID 1652 | RSS: Main: 257478656 08:01:39 INFO - PID 1652 | 08:01:41 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 08:01:42 INFO - PID 1652 | RSS: Main: 258748416 08:01:42 INFO - PID 1652 | 08:01:44 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:01:44 INFO - PID 1652 | RSS: Main: 260349952 08:01:44 INFO - PID 1652 | 08:01:47 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:48 INFO - PID 1652 | RSS: Main: 265756672 08:01:48 INFO - PID 1652 | 08:01:51 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:52 INFO - PID 1652 | RSS: Main: 266866688 08:01:52 INFO - PID 1652 | 08:01:55 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 08:01:56 INFO - PID 1652 | RSS: Main: 266944512 08:01:56 INFO - PID 1652 | 08:01:57 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:01:58 INFO - PID 1652 | RSS: Main: 266637312 08:01:58 INFO - PID 1652 | 08:02:00 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:02:00 INFO - PID 1652 | RSS: Main: 266620928 08:02:00 INFO - PID 1652 | 08:02:03 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:02:03 INFO - PID 1652 | RSS: Main: 266268672 08:02:03 INFO - PID 1652 | 08:02:06 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:02:07 INFO - PID 1652 | RSS: Main: 266428416 08:02:07 INFO - PID 1652 | 08:02:10 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:02:10 INFO - PID 1652 | RSS: Main: 266584064 08:02:10 INFO - PID 1652 | 08:02:12 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 08:02:13 INFO - PID 1652 | RSS: Main: 268132352 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | __start_tp_report 08:02:13 INFO - PID 1652 | _x_x_mozilla_page_load 08:02:13 INFO - PID 1652 | _x_x_mozilla_page_load_details 08:02:13 INFO - PID 1652 | |i|pagename|runs| 08:02:13 INFO - PID 1652 | |0;ai-astar;102;115;115;114;114;115;116;114;115;113 08:02:13 INFO - PID 1652 | |1;audio-beat-detection;143;132;99;157;108;150;143;148;142;113 08:02:13 INFO - PID 1652 | |2;audio-dft;201;205;203;222;219;198;198;203;198;195 08:02:13 INFO - PID 1652 | |3;audio-fft;87;80;86;111;65;62;62;57;80;61 08:02:13 INFO - PID 1652 | |4;audio-oscillator;91;95;72;100;100;103;86;102;106;79 08:02:13 INFO - PID 1652 | |5;imaging-gaussian-blur;90;92;90;90;90;91;90;100;136;88 08:02:13 INFO - PID 1652 | |6;imaging-darkroom;118;153;97;99;97;124;135;111;152;127 08:02:13 INFO - PID 1652 | |7;imaging-desaturate;93;146;146;146;92;90;91;90;96;91 08:02:13 INFO - PID 1652 | |8;json-parse-financial;49;51;50;51;51;50;49;52;51;50 08:02:13 INFO - PID 1652 | |9;json-stringify-tinderbox;59;57;64;62;83;66;60;58;58;60 08:02:13 INFO - PID 1652 | |10;stanford-crypto-aes;84;81;86;82;84;82;84;83;84;80 08:02:13 INFO - PID 1652 | |11;stanford-crypto-ccm;144;140;135;135;138;147;141;144;232;152 08:02:13 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;181;182;180;185;180;180;195;185;182;186 08:02:13 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;68;68;70;68;79;62;59;95;96;95 08:02:13 INFO - PID 1652 | __end_tp_report 08:02:13 INFO - PID 1652 | __start_cc_report 08:02:13 INFO - PID 1652 | _x_x_mozilla_cycle_collect,969 08:02:13 INFO - PID 1652 | __end_cc_report 08:02:13 INFO - PID 1652 | __startTimestamp1494342133017__endTimestamp 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | ------- Summary: start ------- 08:02:13 INFO - PID 1652 | Number of tests: 14 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:4.06 (3.5%) stddev-sans-first:0.88 08:02:13 INFO - PID 1652 | Values: 102.0 115.0 115.0 114.0 114.0 115.0 116.0 114.0 115.0 113.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:145.50 stddev:19.86 (13.7%) stddev-sans-first:20.77 08:02:13 INFO - PID 1652 | Values: 143.0 132.0 99.0 157.0 108.0 150.0 143.0 148.0 142.0 113.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:204.20 Median:203.00 stddev:9.13 (4.5%) stddev-sans-first:9.61 08:02:13 INFO - PID 1652 | Values: 201.0 205.0 203.0 222.0 219.0 198.0 198.0 203.0 198.0 195.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:75.10 Median:72.50 stddev:16.89 (23.3%) stddev-sans-first:17.36 08:02:13 INFO - PID 1652 | Values: 87.0 80.0 86.0 111.0 65.0 62.0 62.0 57.0 80.0 61.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:75.50 stddev:11.26 (14.9%) stddev-sans-first:11.91 08:02:13 INFO - PID 1652 | Values: 91.0 95.0 72.0 100.0 100.0 103.0 86.0 102.0 106.0 79.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:90.00 stddev:14.53 (16.1%) stddev-sans-first:15.26 08:02:13 INFO - PID 1652 | Values: 90.0 92.0 90.0 90.0 90.0 91.0 90.0 100.0 136.0 88.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:121.30 Median:152.50 stddev:21.00 (13.8%) stddev-sans-first:22.24 08:02:13 INFO - PID 1652 | Values: 118.0 153.0 97.0 99.0 97.0 124.0 135.0 111.0 152.0 127.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:108.10 Median:91.00 stddev:26.21 (28.8%) stddev-sans-first:27.22 08:02:13 INFO - PID 1652 | Values: 93.0 146.0 146.0 146.0 92.0 90.0 91.0 90.0 96.0 91.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:0.88 08:02:13 INFO - PID 1652 | Values: 49.0 51.0 50.0 51.0 51.0 50.0 49.0 52.0 51.0 50.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:61.00 stddev:7.67 (12.6%) stddev-sans-first:8.02 08:02:13 INFO - PID 1652 | Values: 59.0 57.0 64.0 62.0 83.0 66.0 60.0 58.0 58.0 60.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:84.00 stddev:1.76 (2.1%) stddev-sans-first:1.83 08:02:13 INFO - PID 1652 | Values: 84.0 81.0 86.0 82.0 84.0 82.0 84.0 83.0 84.0 80.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:150.80 Median:144.00 stddev:29.02 (20.2%) stddev-sans-first:30.67 08:02:13 INFO - PID 1652 | Values: 144.0 140.0 135.0 135.0 138.0 147.0 141.0 144.0 232.0 152.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:183.50 stddev:4.60 (2.5%) stddev-sans-first:4.78 08:02:13 INFO - PID 1652 | Values: 181.0 182.0 180.0 185.0 180.0 180.0 195.0 185.0 182.0 186.0 08:02:13 INFO - PID 1652 | 08:02:13 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:74.50 stddev:14.31 (19.2%) stddev-sans-first:14.89 08:02:13 INFO - PID 1652 | Values: 68.0 68.0 70.0 68.0 79.0 62.0 59.0 95.0 96.0 95.0 08:02:13 INFO - PID 1652 | -------- Summary: end -------- 08:02:13 INFO - PID 1652 | 08:02:13 INFO - TEST-INFO | 1652: exit 0 08:02:14 INFO - TEST-OK | kraken | took 61627ms 08:02:14 INFO - SUITE-END | took 1176s 08:02:14 INFO - Completed test suite (00:19:36) 08:02:14 INFO - javascript benchmark 08:02:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7933.202047900761, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3643.7267204959617, 3648.525691660084, 3671.9816400917994, 3673.871414500493, 3688.0964163779877, 4724.645651576128, 5643.633163844353, 6026.704258584404, 6083.756649734005, 6179.196704428418, 6235.282942461618, 6282.0, 6336.619802811834, 6346.524010699193, 6362.650054247015, 5391.137418013119, 5474.343078830546, 5530.170474428827, 5532.170174473841, 5633.521150702195, 5642.858928526779, 5652.886942261152, 5653.208550802891, 5659.547236221113, 5663.8584035399035, 5439.428859969726, 5522.972385138089, 5553.12549705741, 5559.499645031926, 5573.554115670777, 5561.360443549003, 5586.106223004341, 5604.523615492688, 5620.522255608278, 5630.15547667849, 5462.016836969344, 5516.862078448031, 5525.0, 5532.948739739437, 5568.1647752837, 6133.539984501181, 6188.535859810532, 6273.0, 6354.459870910978, 6379.744810207632, 6703.363180497845, 6792.898106528406, 6794.796156115324, 6812.965935170342, 6814.250432452426, 6909.7581584644795, 6915.446764258847, 6922.2731613180895, 6940.72237110515, 6943.0, 6274.529410294246, 6307.085472606446, 6307.905381419282, 6363.936360636427, 6381.521385895983, 6885.345892140239, 6987.0, 7044.22513523512, 7062.0466237057335, 7090.220075791659, 5675.971620141873, 6455.4512866406885, 6529.608223506605, 6612.07430959666, 6730.0241464988285, 6844.1444819397575, 6853.451723862079, 6904.102466679299, 6913.89629155553, 6927.445804335641, 6560.934390656128, 6803.489738269551, 6804.149481314836, 6815.795526134224, 6835.111435513351, 6638.302978187317, 6643.966780166165, 6671.699773510204, 6783.18601767791, 6799.184097908283, 5428.348598168166, 5430.321209848769, 5437.102878025161, 5439.401665816757, 5453.15476101205, 4429.003474218275, 4628.930566041512, 4803.207470767354, 4803.519648035239, 4831.323614693945, 6288.654124023131, 6293.590916590407, 6347.492200623939, 6447.323031081763, 6492.967535162388, 6943.652817359111, 6949.44404447643, 6969.930300697029, 6991.370776630128, 6997.300269973064, 6473.255575608865, 6498.155239818888, 6510.967445162744, 6520.967395163088, 6527.184101987252, 5885.882282354414, 5954.255718035246, 5974.2233509643465, 6039.78860739872, 6108.053251745987, 6137.631742095488, 6912.654367281616, 7015.894761578683, 7046.0, 7153.177384600837, 5627.971860140673, 5768.0, 6971.58170509771, 6988.510804243858, 6991.895121573282, 7012.4390048796995, 7105.751298704728, 7106.147262328554, 7138.571685698875, 7141.64291785419, 5860.267466566679, 6575.2767195607485, 6691.799246022627, 6726.730930762715, 6829.590224586541, 6785.626790526569, 6946.722131114699, 6961.095057642474, 6964.303569642995, 6975.8604827902145, 6499.2200935887995, 6573.80278591643, 6580.539362244597, 6626.469882409299, 6652.800415987334, 6420.518461115528, 6440.677966101583, 6445.709943052668, 6448.25845027809, 6455.515836312202, 6213.2233470816145, 6355.713992870239, 6359.7456101755415, 6437.356264373525, 6500.414962653384, 6639.502037347315, 6670.199576050905, 6670.999350097524, 6715.059891615276, 6717.0, 6498.545101842826, 6520.445762110274, 6522.05430212626, 6526.804195874131, 6557.540972131905], "value": 6195.293087471145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.3557154276579, 833.1044127562868, 1037.5953378182505, 1108.7061928588926, 1137.0562433180462, 37494.625053749456, 38362.61637383625, 38445.807770961175, 38446.42330365047, 38592.80703596482, 31518.896838610654, 37844.0, 37905.86282411532, 38185.42721859174, 38310.8084459578, 7790.999999999985, 7946.801329966739, 7963.681452741884, 8268.049174344967, 8541.487510749344, 8511.0, 8613.655453781841, 8614.095519970408, 8614.44006139602, 8620.836187114723, 8512.914870851275, 8573.571321433934, 8599.140085991414, 8625.396222264444, 8639.654413823471, 8479.2792612628, 8573.0, 8617.35369847264, 8617.95691021544, 8670.393072484929, 8271.296939760128, 8286.0, 8363.58182090893, 8381.95809020951, 8387.790305242357, 37023.18698569196, 37132.0, 37134.25731485355, 37307.81346093252, 37483.0, 3567.4292113261754, 3587.964120358789, 3608.873689420884, 3611.6930060944587, 3615.132368231632, 30644.38711225763, 30664.38671226563, 30712.925047623226, 30740.846295768602, 30752.38495230083, 3098.891538796154, 3163.1617621330365, 3179.82510961897, 3183.5383869338816, 3201.807891526516, 296608.0, 299252.0, 300634.0, 300733.49633251695, 302384.0, 34634.48048279278, 45927.622171334915, 46593.534064659594, 49057.75471122622, 49562.50437495651, 40745.0, 41187.0, 50406.243906341435, 51013.744931275105, 51069.489305107214, 11669.0, 11775.88224117765, 14008.649783755283, 14209.218492982778, 14295.0, 9874.308798384043, 10557.788844223227, 11128.610498632508, 11370.147238957112, 11538.442310288172, 12094.39528023613, 13699.726005479835, 13844.792328115087, 13888.722225555432, 13932.955028372913, 5202.973985130126, 5935.872184284972, 5964.85087872798, 5999.340072592011, 6056.303525094582, 894.5080205886736, 1041.6874937518714, 1046.398320965448, 1058.2909450668071, 1091.9454027298602, 19761.308354207533, 22451.550968980857, 22725.886370568373, 25076.623850642256, 25235.0, 1152.4180288954024, 1152.458344578047, 1185.9110566707532, 1188.5958774016876, 1199.8020326646006, 10333.689989300334, 12269.509219631114, 12325.75348493043, 12689.555865544662, 12890.80663790044, 336359.0, 336854.6314536872, 337517.0, 338598.0, 338917.3054134763, 56477.0, 56767.71616141893, 56813.715931420906, 56875.43124568784, 61639.38360616426, 1526.809148856393, 1532.9156896370807, 1568.6941046496052, 1569.0977687829543, 1585.1677869118805, 24689.753102468745, 30494.695053049185, 30562.694373055983, 30963.0, 31161.90933317323, 41947.1610567793, 45452.0, 48376.0, 51313.48686513087, 53223.0, 230131.84934075223, 232092.0, 275848.0, 278566.60716697096, 279300.0, 34056.0, 35052.0, 35294.47058294179, 36062.0, 36069.27861442704, 42821.57178428176, 43625.78187109044, 43677.344839826794, 45053.87365315893, 45096.77451612852, 29599.408011840074, 30143.698563014965, 30576.929807456632, 30665.846670766503, 30802.69197308088, 30708.0, 30745.538816917317, 31111.355534779796, 31457.741690333045, 31533.0, 37250.8137459311, 37325.44011839879, 37374.439383409815, 37424.6257537432, 37480.81259593685, 26047.479050419264, 29312.853435732686, 31950.68049319477, 32158.51762223615, 32205.0, 21500.0, 23155.768442315362, 24836.875815620806, 24979.625305620793, 25355.85898634529], "value": 17694.299130773998, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.20757118259183, 436.256183207631, 444.19378827428216, 450.9458864936207, 465.58795466012566, 21654.242101526448, 22198.66701999467, 22437.32688019358, 22545.436364090885, 22801.885990570066, 19423.83456992578, 22962.88518557405, 23148.30555083346, 23284.76715232847, 23495.647565286534, 4467.771492311362, 5932.495737862276, 6190.41191086846, 6190.504759619243, 6192.845178870519, 5993.430624090726, 6108.725107370179, 6140.9385906140815, 6143.692815359236, 6149.477294429978, 5828.6502809831545, 6018.8495287617725, 6093.0, 6099.054646529795, 6106.969465152668, 6012.7294271757655, 6096.634201947897, 6103.176071230416, 6108.81673549792, 6125.234345706786, 5350.91973620396, 5384.946150538483, 5400.189971504266, 5427.565794736412, 5437.456254374571, 27511.17466476009, 27563.0, 27630.861845690844, 27801.721982780116, 28015.0, 2292.1748170658548, 2331.6619090231993, 2347.178487529351, 2348.518553696488, 2354.81161507079, 17763.733543996852, 18025.459236222934, 18087.276508939627, 18088.909555452137, 18402.815971840246, 2146.5170336674278, 2174.402039439151, 2207.746109197447, 2212.4911270407897, 2226.065052677879, 135526.0, 135972.960405594, 136097.3195134028, 137156.0, 138416.0, 12641.620751377473, 12938.288394138224, 13098.017648676387, 13109.27898965547, 13222.867771322357, 12412.875871241173, 16733.995960242424, 17094.0, 17115.14424278781, 17138.0, 8822.602982865787, 9142.217267632748, 9143.908560914439, 9241.445513269226, 9257.120573545637, 8596.097409772008, 8612.267957223707, 8618.482891026559, 8792.956035219782, 8793.340499462565, 8015.879761803578, 8133.389995750224, 8152.918470815334, 8168.469049511763, 8222.917770822334, 2166.068590506066, 2174.5868285025795, 2181.825453963679, 2182.127149140357, 2200.9779902201094, 991.9008099190168, 995.5669283861398, 1013.8225810483136, 1050.112654806687, 1052.1267348101057, 20971.58056838855, 21930.561388772134, 22334.21830235934, 22388.664170037464, 22399.88800055989, 1031.242037102729, 1046.581367453025, 1063.8563793887881, 1072.7532667486366, 1079.0666073846066, 9637.469939153274, 9970.50147492637, 11047.779044419067, 11549.36478493691, 11555.133364997659, 488357.0, 529590.0, 571014.0, 572346.0, 583357.0, 131119.0, 135583.32208338895, 136611.0, 137188.0, 139747.0, 1187.2638963842473, 1199.232491205629, 1252.3362617812575, 1258.3330834657645, 1277.4251586785983, 20805.89597052005, 22692.0, 22860.771392285864, 22909.19817806369, 22914.0, 59232.1115183264, 59381.40618593759, 59833.10250346161, 60164.69917650559, 60646.69676651765, 54958.45041549693, 59455.0, 75079.0, 77897.0, 78805.0, 7928.0, 8918.777030574287, 9158.496282704515, 9188.724338269863, 9367.250619950524, 14098.577042688736, 14195.64510887236, 14261.572152835432, 14449.133052016912, 14499.275036248357, 11682.94158529202, 11863.228890122115, 12030.037596992395, 12112.394380280775, 12142.210756300812, 10366.481675916024, 10842.891571084188, 11029.062529685067, 11385.430728463709, 11693.239939403911, 10816.810150883239, 11706.824397634213, 12107.152499325315, 12370.13409061393, 12526.749465010831, 8913.153250441197, 9057.320700947586, 9113.77215569616, 9117.0, 9149.993500715049, 11730.061595072544, 11844.644660660195, 12100.334481603244, 12151.331676757864, 12414.441350139085], "value": 10588.476455545153, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1197.8323034775133, 1379.6206043338082, 1382.6405134664983, 1444.894655588475, 1447.3125265498886, 9678.709638710832, 11201.551937922484, 11637.010854077404, 11767.058635309177, 12052.276863388202, 10413.271071025032, 11587.073034157269, 11692.0, 11772.175947683665, 11776.293422394663, 2474.824458382263, 2520.521100990815, 2524.3436706456364, 2527.5324065047935, 2532.5821239495463, 2450.803935685141, 2492.962605560918, 2500.712418071918, 2507.260358194337, 2511.183865243794, 2056.640087984604, 2446.8164887633498, 2485.8632775197357, 2516.697996240454, 2520.1305549585363, 2447.6328550717444, 2466.5436894174545, 2506.0101260002198, 2508.5108403861254, 2520.155747824481, 2419.576574099543, 2476.4304210031614, 2492.439201179738, 2494.725580186178, 2549.68128983877, 9985.0, 11665.825012624817, 11796.0, 11876.465559049864, 11906.940465297705, 6566.409023187936, 6781.38967492928, 6811.284815094394, 6825.897611535831, 6842.349976752201, 4017.799110044486, 4366.432363792718, 4423.424954755861, 4425.690201685883, 4444.866654000353, 1215.7264615461538, 1216.22769541341, 1240.962771116868, 1255.805350170725, 1258.0, 13405.932970335183, 15585.29866156037, 16629.50111496645, 16727.498175054767, 16765.7485137723, 5516.448355164452, 5639.802606908821, 5653.378128405872, 5782.074868021181, 5800.0, 11798.292102473879, 11863.16957812962, 11871.109666775026, 11877.465514051715, 11877.465514051715, 5959.225300710967, 6286.465650419766, 6578.671066446658, 6599.208095028627, 6611.206655201407, 5698.772049117989, 5896.3219229788265, 6221.097940798559, 6251.593646412968, 6292.874142517124, 4346.673999450054, 4423.225935461346, 4444.755538445352, 4465.441819772528, 4472.575105364985, 1126.4987080748988, 1245.735578387937, 1256.3969294738577, 1274.0762946863636, 1286.4468278640088, 789.7314912929631, 792.1661353965667, 813.4102775487725, 820.1429506166071, 848.7538613802052, 6144.293406258248, 6153.569250152446, 6321.778737744157, 6362.84092897672, 6421.29365769765, 556.2157358125024, 587.0782870892742, 597.4115496236204, 604.4197570332442, 619.2228752915153, 3918.6081391861157, 4230.217409779139, 4288.678349123766, 4296.226679197712, 4378.387025816324, 14627.26863656813, 15080.698386032218, 15214.315355809014, 15225.543233703007, 15276.312565934559, 14939.0, 14987.700245995236, 15346.462873799363, 15384.076955382712, 15402.922985385225, 6228.719707613078, 7609.885851712229, 8389.161083891684, 8829.381943264038, 8854.601542930584, 6354.872902541831, 7154.892676609751, 7169.928300716926, 7243.855122897618, 7255.238199988925, 12626.494940202288, 12996.415161317953, 13033.15284506504, 13046.739065218453, 13094.934525327313, 13467.0, 13675.863241367459, 13726.45094196221, 13981.370838312097, 14133.434662613381, 9254.398464099811, 9551.522423878918, 9551.856722149034, 9556.952215239158, 9573.042695730372, 10534.52594633228, 10826.783464330827, 10832.891671083189, 10918.07196388316, 10932.234743567873, 8312.293455056146, 9552.665656701982, 9644.421334719938, 9689.757756056155, 9782.972787857172, 9391.577379017825, 9415.670451534163, 9429.622815087594, 9522.857157142787, 9552.044795520393, 8250.958745206235, 8314.376421768271, 8325.0, 8342.332613391036, 8368.665253389796, 6135.754569817157, 6263.0, 6263.937360626335, 6279.183706118175, 6322.36776322364, 6072.635641861502, 6269.12232287471, 6351.491880649629, 6380.425761681286, 6387.776427825004], "value": 5322.074204005054, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.49212657393633, 384.819135006547, 408.2875382457612, 409.8811344710034, 411.9691023173262, 6262.185915830947, 6275.748970041199, 6460.515461340395, 6494.935050649492, 6534.346565343463, 6125.877482450348, 6206.989610039139, 6245.56281060326, 6246.657503436211, 6258.374162583739, 4532.161550113223, 4562.498125206224, 4571.47428045774, 4574.81700731972, 4593.42582177227, 4394.934075988863, 4518.186726389248, 4535.7278563286145, 4568.47462541807, 4583.175028494869, 3606.531150950386, 4383.320585309282, 4479.454588167077, 4486.573775491323, 4499.730016199039, 4469.575390337913, 4487.775611219442, 4490.8877278067985, 4511.030128522383, 4512.796924138422, 3747.4940882980995, 3854.2291541691493, 3862.864799732024, 3866.8066596670055, 3870.3420418528917, 4457.398251236074, 5044.672096313728, 5841.707914604252, 6174.783882564134, 6222.377762223787, 5450.645708029005, 5451.836444906659, 5466.0, 5479.863003424906, 5545.72271386429, 6455.870882582369, 6655.304601636345, 6662.800115996528, 6714.093597364391, 6730.427913627299, 3762.473253744478, 4184.476940382452, 4361.105973275471, 4428.822847086113, 4443.600075993144, 5863.153166641721, 6641.601503909733, 6730.427913627347, 7094.219635840053, 7157.248488908694, 3976.284268831638, 4459.509453960061, 4469.664775141878, 4470.9105817883465, 4471.217536931024, 3513.683768460851, 4576.382188404589, 4576.565226303496, 4585.9541404585525, 4675.251959686434, 4693.83571575, 5199.63602547818, 5309.044372012998, 5365.919511207335, 5414.593905457106, 6396.9360306397275, 6575.046618240328, 6757.0, 6800.829979250559, 6860.931390686029, 1334.9532766353132, 1551.4880089570415, 1551.67414842882, 1552.6351307442742, 1555.572217640158, 981.5730157381562, 1010.7422607235255, 1011.3780025284398, 1019.56158851693, 1030.160419258302, 6469.805905822833, 6478.242619280806, 6490.4807615390655, 6493.772717954849, 6548.967255163694, 6152.446279834747, 6852.486063545254, 6928.972110294714, 6998.405135563432, 7081.539699919489, 5189.273501709764, 6400.551961362753, 6437.806865794034, 6452.806415807533, 6489.825908320766, 3324.351751408452, 3552.4848896909803, 3672.2288319452678, 3692.390755525362, 3707.240015796809, 6117.694115294217, 7158.033665455201, 7208.423326134001, 7285.854282914418, 7395.151212196951, 6431.488600178955, 6463.48292136628, 7021.403180729695, 7180.748673796392, 7231.349178573849, 6234.937650623527, 6751.324867513307, 6812.046313516112, 7280.635968201463, 7316.597587132653, 6433.195850518685, 6522.412982831568, 6803.285655006153, 7027.613481258375, 7107.50247482692, 6871.656417179221, 6940.444764418935, 6947.270536593584, 6985.650717464208, 7002.9691389496475, 5428.728563571726, 6826.829329266808, 7114.288571142844, 7114.964425177841, 7315.817104572216, 4224.394730002579, 4454.309582014793, 4466.754328511963, 4485.380058539709, 4493.820247190076, 6363.659078983571, 6575.2575567475615, 6990.0, 7023.403010744144, 7078.716851325889, 6622.741679080959, 6750.493712971449, 6808.421284190899, 6855.520113592001, 6864.4165245954655, 6576.2766095730385, 6791.5585486945165, 6805.319468053155, 6861.416779573592, 6863.72445208081, 5840.620359676607, 5933.940660593339, 6126.0, 6614.801555953329, 6729.629870357177, 6497.9025314619375, 6716.328367163244, 6776.934643493947, 6791.388775010273, 6824.658767061726, 6272.372762723691, 6273.937260627518, 6446.548741588043, 6655.267920528641, 6664.933350666432], "value": 4865.054074456737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.6675062972291, 829.2329595124515, 837.6774941647463, 858.7848194804352, 872.0189786490198, 13906.374213160407, 14415.351309191085, 15694.136822474758, 16078.27647755851, 16180.433684821033, 12870.871291287085, 13070.954323654109, 16969.660606787857, 16977.2360243789, 16996.320147194096, 832.4381042796089, 980.3480685344256, 986.7138529826377, 1001.0590045357377, 1003.8795344558627, 823.3577809308719, 974.8830140383164, 993.5975929748463, 997.5710444508858, 999.7350702063959, 1046.2310202001522, 1048.1038711901328, 1048.5229220704562, 1051.0277992856616, 1053.520648105114, 986.5116767200246, 1009.5305682857506, 1024.4212020208595, 1034.6430481483876, 1036.984445233322, 756.5800980455845, 759.4456047085658, 759.502525845572, 759.5101159751985, 761.8857171424276, 16649.4172703956, 16789.83210167895, 16814.579635509086, 16824.915875420666, 17099.74350384745, 16936.745948810778, 17195.82804171955, 17517.824821751874, 17568.648627027516, 17759.0, 13903.096298740651, 14124.50564230247, 14140.92929535356, 14259.144451332953, 14269.714605707932, 3469.340825243221, 3474.982625086858, 3494.2836718472654, 3499.6325385834375, 3501.7548771586, 119409.0, 119499.0, 120859.0, 121155.0, 121473.39263303715, 12002.819957700467, 12946.899513541266, 13037.76141266578, 13239.66900827487, 13309.933450332686, 24763.380915477257, 25339.0, 25719.485610288062, 26483.602745958826, 26560.46879062408, 7650.38796896247, 7856.7250146244605, 7887.171846956102, 7895.092064412551, 7931.960340198262, 3900.3564411871725, 4024.5371782245415, 4028.1742242840146, 4037.6164264394833, 4037.899052523652, 4232.470941132358, 4274.418465167845, 4401.757903315349, 4407.625351845065, 4460.888477788081, 893.7229458867772, 909.6582540752337, 947.2422062350092, 951.6336210558985, 971.1114330387758, 648.0764910003227, 665.7170702451439, 668.5754545863412, 669.5413641655482, 683.565935630868, 10986.835197472044, 11722.0, 12039.578614748441, 12123.75752484963, 12238.877611223774, 639.3223183425583, 649.5615459564775, 653.1443808610735, 660.1550015979553, 677.403884581575, 4934.728589927517, 5010.0, 5420.620556561082, 5561.916571251434, 5662.886742265214, 108360.0, 109917.0, 110534.0, 112700.0, 116152.41923790496, 87599.0, 97354.0, 98088.01911980931, 99033.0, 100323.0, 79397.60301198457, 80887.19112808914, 81444.18555814485, 81639.18360816316, 81789.0, 12070.0, 12728.74542509163, 12774.297413642338, 12792.0, 12863.29251891155, 38707.0, 40294.742498345404, 41055.58944410637, 41472.37791433191, 43215.0, 37813.62186378211, 51612.709682258246, 52247.47752522426, 52461.0, 52652.736736316074, 15546.611334716723, 15898.602534936257, 16214.51356459308, 16332.755008675116, 16352.509424717278, 17210.39763608268, 17763.911180444014, 17809.910950445166, 18056.638867222846, 18108.818911810715, 16126.67746645084, 16170.434034808724, 16473.423430179886, 16562.420315288906, 16772.1613919306, 16073.276702548179, 16453.753193701865, 16530.66938661244, 16634.667306654042, 16664.583385414975, 15028.0, 15637.84362156364, 15717.0, 16373.508794736177, 16589.262771643025, 11293.0, 11382.430878456209, 11830.408479575815, 11913.642590722293, 11967.76064478723, 10423.895761042293, 11997.700057498283, 13276.468941242241, 13288.734225315246, 13312.334383280991], "value": 8293.987464028696, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 115.0, 114.0, 114.0, 115.0, 116.0, 114.0, 115.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 132.0, 99.0, 157.0, 108.0, 150.0, 143.0, 148.0, 142.0, 113.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 205.0, 203.0, 222.0, 219.0, 198.0, 198.0, 203.0, 198.0, 195.0], "value": 204.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 86.0, 111.0, 65.0, 62.0, 62.0, 57.0, 80.0, 61.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 72.0, 100.0, 100.0, 103.0, 86.0, 102.0, 106.0, 79.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 90.0, 90.0, 90.0, 91.0, 90.0, 100.0, 136.0, 88.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 153.0, 97.0, 99.0, 97.0, 124.0, 135.0, 111.0, 152.0, 127.0], "value": 121.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 146.0, 146.0, 146.0, 92.0, 90.0, 91.0, 90.0, 96.0, 91.0], "value": 108.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 51.0, 50.0, 51.0, 51.0, 50.0, 49.0, 52.0, 51.0, 50.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 64.0, 62.0, 83.0, 66.0, 60.0, 58.0, 58.0, 60.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 86.0, 82.0, 84.0, 82.0, 84.0, 83.0, 84.0, 80.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 140.0, 135.0, 135.0, 138.0, 147.0, 141.0, 144.0, 232.0, 152.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 180.0, 185.0, 180.0, 180.0, 195.0, 185.0, 182.0, 186.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 68.0, 79.0, 62.0, 59.0, 95.0, 96.0, 95.0], "value": 76.0, "unit": "score"}]}]} 08:02:14 INFO - Return code: 0 08:02:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:02:14 INFO - # TBPL SUCCESS # 08:02:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:02:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:02:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:02:14 INFO - 2017-05-09 08:02:14.342 screenresolution[1659:10913] starting screenresolution argv=screenresolution get 08:02:14 INFO - 2017-05-09 08:02:14.344 screenresolution[1659:10913] Display 0: 1600x1200x32@60 08:02:14 INFO - 2017-05-09 08:02:14.351 screenresolution[1660:10916] starting screenresolution argv=screenresolution list 08:02:14 INFO - Available Modes on Display 0 08:02:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:02:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:02:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:02:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:02:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:02:14 INFO - Intel Iris: 08:02:14 INFO - Chipset Model: Intel Iris 08:02:14 INFO - Type: GPU 08:02:14 INFO - Bus: Built-In 08:02:14 INFO - VRAM (Dynamic, Max): 1536 MB 08:02:14 INFO - Vendor: Intel (0x8086) 08:02:14 INFO - Device ID: 0x0a2e 08:02:14 INFO - Revision ID: 0x0009 08:02:14 INFO - Displays: 08:02:14 INFO - Display: 08:02:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:02:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:02:14 INFO - Display Serial Number: 1600x1200 60 08:02:14 INFO - Main Display: Yes 08:02:14 INFO - Mirror: Off 08:02:14 INFO - Online: Yes 08:02:14 INFO - Rotation: Supported 08:02:14 INFO - Return code: 0 08:02:14 INFO - Running post-action listener: _resource_record_post_action 08:02:14 INFO - [mozharness: 2017-05-09 15:02:14.593961Z] Finished run-tests step (success) 08:02:14 INFO - Running post-run listener: _resource_record_post_run 08:02:14 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 39537664; Write bytes: 532934656; Read time: 255; Write time: 1657 08:02:14 INFO - TinderboxPrint: CPU usage
54.1% 08:02:14 INFO - TinderboxPrint: I/O read bytes / time
39,537,664 / 255 08:02:14 INFO - TinderboxPrint: I/O write bytes / time
532,934,656 / 1,657 08:02:14 INFO - TinderboxPrint: CPU idle
2,197.5 (45.9%) 08:02:14 INFO - TinderboxPrint: CPU system
960.4 (20.1%) 08:02:14 INFO - TinderboxPrint: CPU user
1,631.9 (34.1%) 08:02:14 INFO - TinderboxPrint: Swap in / out
247,439,360 / 0 08:02:14 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209402368; Write bytes: 211044352; Read time: 16171; Write time: 445 08:02:14 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35486720; Write bytes: 320280576; Read time: 228; Write time: 1206 08:02:15 INFO - Running post-run listener: _upload_blobber_files 08:02:15 INFO - Blob upload gear active. 08:02:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:02:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:02:15 INFO - (blobuploader) - INFO - Open directory for files ... 08:02:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:02:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:02:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:16 INFO - (blobuploader) - INFO - Done attempting. 08:02:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:02:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:17 INFO - (blobuploader) - INFO - Done attempting. 08:02:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:02:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:02:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:18 INFO - (blobuploader) - INFO - Done attempting. 08:02:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:02:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:02:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:20 INFO - (blobuploader) - INFO - Done attempting. 08:02:20 INFO - (blobuploader) - INFO - Iteration through files over. 08:02:20 INFO - Return code: 0 08:02:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:02:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:02:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8ff5377139c72543ddf5d3c20a96dc2e0860679b602bcd01606a9e893ddfcbc83dad60b5a18db6381f530a7b47ee75df052afc9b62dc3c09238e224f675c204", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f51d70d33b9b6953d469cc6e97ffe3fc0631a8e17fbf542e674d5aa8583d753366d900913dcb8e6ad302f5f808115e44f6e36f4c97b7ab3592569388dd8ffec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/432eb688c779d7e9a6549804af5b1eebe1363887398ac919e61f37cb2c02cfb259f95c11b9495355862f22abbf014908c815c0b03406f7841f47460c98df9869", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66f29e46111edd4b6a7eae537c5709d5d261976c0fa7cfc2287e0097e6c5aac6e9700a0fdb0e90a71b7dd1a98faa20bbc8de54b11f4369a707808cf504e27e37"} 08:02:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:02:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:02:20 INFO - Contents: 08:02:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8ff5377139c72543ddf5d3c20a96dc2e0860679b602bcd01606a9e893ddfcbc83dad60b5a18db6381f530a7b47ee75df052afc9b62dc3c09238e224f675c204", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f51d70d33b9b6953d469cc6e97ffe3fc0631a8e17fbf542e674d5aa8583d753366d900913dcb8e6ad302f5f808115e44f6e36f4c97b7ab3592569388dd8ffec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/432eb688c779d7e9a6549804af5b1eebe1363887398ac919e61f37cb2c02cfb259f95c11b9495355862f22abbf014908c815c0b03406f7841f47460c98df9869", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66f29e46111edd4b6a7eae537c5709d5d261976c0fa7cfc2287e0097e6c5aac6e9700a0fdb0e90a71b7dd1a98faa20bbc8de54b11f4369a707808cf504e27e37"} 08:02:20 INFO - Running post-run listener: copy_logs_to_upload_dir 08:02:20 INFO - Copying logs to upload dir... 08:02:20 INFO - mkdir: /builds/slave/test/build/upload/logs 08:02:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.530798 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-05-09 08:02:20.684579) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 08:02:20.692282) ========= 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.ijTvTei6hR/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.L1KKwGjwWB/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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/f8ff5377139c72543ddf5d3c20a96dc2e0860679b602bcd01606a9e893ddfcbc83dad60b5a18db6381f530a7b47ee75df052afc9b62dc3c09238e224f675c204", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f51d70d33b9b6953d469cc6e97ffe3fc0631a8e17fbf542e674d5aa8583d753366d900913dcb8e6ad302f5f808115e44f6e36f4c97b7ab3592569388dd8ffec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/432eb688c779d7e9a6549804af5b1eebe1363887398ac919e61f37cb2c02cfb259f95c11b9495355862f22abbf014908c815c0b03406f7841f47460c98df9869", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66f29e46111edd4b6a7eae537c5709d5d261976c0fa7cfc2287e0097e6c5aac6e9700a0fdb0e90a71b7dd1a98faa20bbc8de54b11f4369a707808cf504e27e37"} build_url:https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/NXfWR7PoTJOKXN4EWbj3gw/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/f8ff5377139c72543ddf5d3c20a96dc2e0860679b602bcd01606a9e893ddfcbc83dad60b5a18db6381f530a7b47ee75df052afc9b62dc3c09238e224f675c204", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f51d70d33b9b6953d469cc6e97ffe3fc0631a8e17fbf542e674d5aa8583d753366d900913dcb8e6ad302f5f808115e44f6e36f4c97b7ab3592569388dd8ffec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/432eb688c779d7e9a6549804af5b1eebe1363887398ac919e61f37cb2c02cfb259f95c11b9495355862f22abbf014908c815c0b03406f7841f47460c98df9869", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66f29e46111edd4b6a7eae537c5709d5d261976c0fa7cfc2287e0097e6c5aac6e9700a0fdb0e90a71b7dd1a98faa20bbc8de54b11f4369a707808cf504e27e37"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 08:02:20.732954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 08:02:20.733316) ========= 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.ijTvTei6hR/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.L1KKwGjwWB/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.005107 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 08:02:20.784736) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 08:02:20.785719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 08:02:20.786240) ========= ========= Total master_lag: 0.21 =========