builder: pine_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0180 starttime: 1492042992.28 results: success (0) buildid: 20170412155613 builduid: c2812f1e5c2445aba5dcf6262b070367 revision: c7159022ffd95b4faa3a19a1796bc782312bc045 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 17:23:12.284042) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 17:23:12.284440) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 17:23:12.284726) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 17:23:12.313871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 17:23:12.314178) ========= 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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-04-12 17:23:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.1M=0.001s 2017-04-12 17:23:12 (14.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130970 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 17:23:12.470021) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 17:23:12.470328) ========= 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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.041192 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 17:23:12.533418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-12 17:23:12.533772) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev c7159022ffd95b4faa3a19a1796bc782312bc045 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev c7159022ffd95b4faa3a19a1796bc782312bc045 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-04-12 17:23:12,640 truncating revision to first 12 chars 2017-04-12 17:23:12,640 Setting DEBUG logging. 2017-04-12 17:23:12,640 attempt 1/10 2017-04-12 17:23:12,640 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/c7159022ffd9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-12 17:23:14,632 unpacking tar archive at: pine-c7159022ffd9/testing/mozharness/ program finished with exit code 0 elapsedTime=2.259174 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-12 17:23:14.819775) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 17:23:14.820092) ========= script_repo_revision: c7159022ffd95b4faa3a19a1796bc782312bc045 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 17:23:14.820492) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 17:23:14.820771) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 17:23:14.840291) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-12 17:23:14.840596) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 17:23:15 INFO - MultiFileLogger online at 20170412 17:23:15 in /builds/slave/test 17:23:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 17:23:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:23:15 INFO - {'append_to_log': False, 17:23:15 INFO - 'base_work_dir': '/builds/slave/test', 17:23:15 INFO - 'blob_upload_branch': 'Pine', 17:23:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:23:15 INFO - 'branch': 'Pine', 17:23:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:23:15 INFO - 'config_files': ('talos/mac_config.py',), 17:23:15 INFO - 'default_actions': ('clobber', 17:23:15 INFO - 'read-buildbot-config', 17:23:15 INFO - 'download-and-extract', 17:23:15 INFO - 'populate-webroot', 17:23:15 INFO - 'create-virtualenv', 17:23:15 INFO - 'install', 17:23:15 INFO - 'run-tests'), 17:23:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:23:15 INFO - 'download_minidump_stackwalk': True, 17:23:15 INFO - 'download_symbols': 'ondemand', 17:23:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:23:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:23:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:23:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:23:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:23:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:23:15 INFO - 'gecko_profile': False, 17:23:15 INFO - 'gecko_profile_interval': 0, 17:23:15 INFO - 'installer_path': 'installer.exe', 17:23:15 INFO - 'log_level': 'info', 17:23:15 INFO - 'log_name': 'talos', 17:23:15 INFO - 'log_to_console': True, 17:23:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:23:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:23:15 INFO - 'opt_config_files': (), 17:23:15 INFO - 'pip_index': False, 17:23:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:23:15 INFO - 'cmd': ('bash', 17:23:15 INFO - '-c', 17:23:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:23:15 INFO - 'enabled': True, 17:23:15 INFO - 'halt_on_failure': False, 17:23:15 INFO - 'name': 'check_screen_resolution'},), 17:23:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:23:15 INFO - 'cmd': ('bash', 17:23:15 INFO - '-c', 17:23:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:23:15 INFO - 'enabled': True, 17:23:15 INFO - 'halt_on_failure': False, 17:23:15 INFO - 'name': 'check_screen_resolution'},), 17:23:15 INFO - 'run_cmd_checks_enabled': True, 17:23:15 INFO - 'suite': 'dromaeojs', 17:23:15 INFO - 'system_bits': '32', 17:23:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:23:15 INFO - 'title': 't-yosemite-r7-0180', 17:23:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:23:15 INFO - 'use_talos_json': True, 17:23:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:23:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:23:15 INFO - 'work_dir': 'build'} 17:23:15 INFO - [mozharness: 2017-04-13 00:23:15.054062Z] Running clobber step. 17:23:15 INFO - Running pre-action listener: _resource_record_pre_action 17:23:15 INFO - Running main action method: clobber 17:23:15 INFO - rmtree: /builds/slave/test/build 17:23:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:23:17 INFO - Running post-action listener: _resource_record_post_action 17:23:17 INFO - [mozharness: 2017-04-13 00:23:17.670146Z] Finished clobber step (success) 17:23:17 INFO - [mozharness: 2017-04-13 00:23:17.670272Z] Running read-buildbot-config step. 17:23:17 INFO - Running pre-action listener: _resource_record_pre_action 17:23:17 INFO - Running main action method: read_buildbot_config 17:23:17 INFO - Using buildbot properties: 17:23:17 INFO - { 17:23:17 INFO - "project": "", 17:23:17 INFO - "product": "firefox", 17:23:17 INFO - "script_repo_revision": "default", 17:23:17 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs", 17:23:17 INFO - "repository": "", 17:23:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs", 17:23:17 INFO - "buildid": "20170412155613", 17:23:17 INFO - "pgo_build": "False", 17:23:17 INFO - "basedir": "/builds/slave/test", 17:23:17 INFO - "buildnumber": 7, 17:23:17 INFO - "slavename": "t-yosemite-r7-0180", 17:23:17 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 17:23:17 INFO - "platform": "yosemite_r7", 17:23:17 INFO - "scheduler": "tests-pine-macosx64-talos", 17:23:17 INFO - "branch": "pine", 17:23:17 INFO - "repo_path": "projects/pine", 17:23:17 INFO - "revision": "c7159022ffd95b4faa3a19a1796bc782312bc045", 17:23:17 INFO - "stage_platform": "macosx64", 17:23:17 INFO - "builduid": "c2812f1e5c2445aba5dcf6262b070367", 17:23:17 INFO - "slavebuilddir": "test" 17:23:17 INFO - } 17:23:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:23:17 INFO - Running post-action listener: _resource_record_post_action 17:23:17 INFO - [mozharness: 2017-04-13 00:23:17.673701Z] Finished read-buildbot-config step (success) 17:23:17 INFO - [mozharness: 2017-04-13 00:23:17.673802Z] Running download-and-extract step. 17:23:17 INFO - Running pre-action listener: _resource_record_pre_action 17:23:17 INFO - Running main action method: download_and_extract 17:23:17 INFO - mkdir: /builds/slave/test/build/tests 17:23:17 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')]} 17:23:17 INFO - trying https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:23:17 INFO - Downloading https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/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 17:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/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 17:23:19 INFO - Downloaded 1325 bytes. 17:23:19 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:23:19 INFO - Using the following test package requirements: 17:23:19 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:23:19 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:23:19 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:23:19 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:23:19 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:23:19 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:23:19 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:23:19 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:23:19 INFO - u'jsshell-mac.zip'], 17:23:19 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:23:19 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:23:19 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:23:19 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:23:19 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:23:19 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:23:19 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:23:19 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:23:19 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:23:19 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:23:19 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:23:19 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:23:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:23:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:23:19 INFO - Fetch https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:23:20 INFO - Expected file size: 52582213 17:23:20 INFO - Obtained file size: 52582213 17:23:37 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 17:23:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:23:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:23:37 INFO - Fetch https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:23:39 INFO - Expected file size: 52582213 17:23:39 INFO - Obtained file size: 52582213 17:23:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:23:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:23:55 INFO - Fetch https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:23:55 INFO - Expected file size: 14405596 17:23:55 INFO - Obtained file size: 14405596 17:23:56 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')]} 17:23:56 INFO - trying https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:23:56 INFO - Downloading https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/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 17:23:58 INFO - Downloaded 70998209 bytes. 17:23:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:23:58 INFO - mkdir: /builds/slave/test/properties 17:23:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:23:58 INFO - Writing to file /builds/slave/test/properties/build_url 17:23:58 INFO - Contents: 17:23:58 INFO - build_url:https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:23:58 INFO - Running post-action listener: _resource_record_post_action 17:23:58 INFO - Running post-action listener: set_extra_try_arguments 17:23:58 INFO - [mozharness: 2017-04-13 00:23:58.997422Z] Finished download-and-extract step (success) 17:23:58 INFO - [mozharness: 2017-04-13 00:23:58.997558Z] Running populate-webroot step. 17:23:58 INFO - Running pre-action listener: _resource_record_pre_action 17:23:58 INFO - Running main action method: populate_webroot 17:23:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:23:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:23:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:23:59 INFO - '--tppagecycles', 17:23:59 INFO - '7'], 17:23:59 INFO - 'tests': ['tsvgm']}}, 17:23:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:23:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:23:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:23:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:23:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:23:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:23:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:23:59 INFO - 'talos_options': ['--disable-e10s'], 17:23:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:23:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:23:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:23:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:23:59 INFO - 'talos_options': ['--disable-e10s'], 17:23:59 INFO - 'tests': ['damp', 'tps']}, 17:23:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:23:59 INFO - 'tests': ['damp', 'tps']}, 17:23:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:23:59 INFO - 'tests': ['dromaeo_dom']}, 17:23:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:23:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:23:59 INFO - 'tests': ['basic_compositor_video']}, 17:23:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:23:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:23:59 INFO - 'tests': ['a11yr', 17:23:59 INFO - 'ts_paint', 17:23:59 INFO - 'tpaint', 17:23:59 INFO - 'sessionrestore', 17:23:59 INFO - 'sessionrestore_no_auto_restore', 17:23:59 INFO - 'tabpaint']}, 17:23:59 INFO - 'other-e10s': {'tests': ['a11yr', 17:23:59 INFO - 'ts_paint', 17:23:59 INFO - 'tpaint', 17:23:59 INFO - 'sessionrestore', 17:23:59 INFO - 'sessionrestore_no_auto_restore', 17:23:59 INFO - 'tabpaint']}, 17:23:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:23:59 INFO - 'ts_paint', 17:23:59 INFO - 'tpaint', 17:23:59 INFO - 'sessionrestore', 17:23:59 INFO - 'sessionrestore_no_auto_restore', 17:23:59 INFO - 'tabpaint']}, 17:23:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:23:59 INFO - 'ts_paint', 17:23:59 INFO - 'tpaint', 17:23:59 INFO - 'sessionrestore', 17:23:59 INFO - 'sessionrestore_no_auto_restore', 17:23:59 INFO - 'tabpaint']}, 17:23:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:23:59 INFO - 'tests': ['a11yr', 17:23:59 INFO - 'ts_paint', 17:23:59 INFO - 'tpaint', 17:23:59 INFO - 'sessionrestore', 17:23:59 INFO - 'sessionrestore_no_auto_restore', 17:23:59 INFO - 'tabpaint']}, 17:23:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:23:59 INFO - 'tests': ['a11yr', 17:23:59 INFO - 'ts_paint', 17:23:59 INFO - 'tpaint', 17:23:59 INFO - 'sessionrestore', 17:23:59 INFO - 'sessionrestore_no_auto_restore', 17:23:59 INFO - 'tabpaint']}, 17:23:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:23:59 INFO - 'tests': ['tsvgx', 17:23:59 INFO - 'tsvgr_opacity', 17:23:59 INFO - 'tart', 17:23:59 INFO - 'tscrollx', 17:23:59 INFO - 'cart', 17:23:59 INFO - 'tsvg_static']}, 17:23:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:23:59 INFO - 'tsvgr_opacity', 17:23:59 INFO - 'tart', 17:23:59 INFO - 'tscrollx', 17:23:59 INFO - 'cart', 17:23:59 INFO - 'tsvg_static']}, 17:23:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:23:59 INFO - 'talos_options': ['--disable-e10s'], 17:23:59 INFO - 'tests': ['tp5o']}, 17:23:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:23:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:23:59 INFO - 'talos_options': ['--disable-e10s', 17:23:59 INFO - '--xperf_path', 17:23:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:23:59 INFO - 'tests': ['tp5n']}, 17:23:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:23:59 INFO - 'talos_options': ['--xperf_path', 17:23:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:23:59 INFO - 'tests': ['tp5n']}}, 17:23:59 INFO - 'talos.zip': {'path': '', 17:23:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:23:59 INFO - Running post-action listener: _resource_record_post_action 17:23:59 INFO - [mozharness: 2017-04-13 00:23:59.016551Z] Finished populate-webroot step (success) 17:23:59 INFO - [mozharness: 2017-04-13 00:23:59.016665Z] Running create-virtualenv step. 17:23:59 INFO - Running pre-action listener: _resource_record_pre_action 17:23:59 INFO - Running main action method: create_virtualenv 17:23:59 INFO - Creating virtualenv /builds/slave/test/build/venv 17:23:59 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 17:23:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:23:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:23:59 INFO - Using real prefix '/tools/python27' 17:23:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:23:59 INFO - Installing distribute.............................................................................................................................................................................................done. 17:24:02 INFO - Installing pip.................done. 17:24:02 INFO - Return code: 0 17:24:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:24:03 INFO - Reading from file tmpfile_stdout 17:24:03 INFO - Output received: 17:24:03 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) 17:24:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:24: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')]} 17:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d177b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee9a4ac570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf55d30>, '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 0x10ce7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4abe8>, '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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 17:24: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', 'pip>=1.5'] in /builds/slave/test/build 17:24: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 pip>=1.5 17:24:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q0gZpsfuDE/Render', 17:24:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:03 INFO - 'HOME': '/Users/cltbld', 17:24:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:03 INFO - 'LOGNAME': 'cltbld', 17:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:03 INFO - 'MOZ_NO_REMOTE': '1', 17:24:03 INFO - 'NO_EM_RESTART': '1', 17:24:03 INFO - 'PAGER': '/bin/cat', 17:24:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:03 INFO - 'PWD': '/builds/slave/test', 17:24:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:03 INFO - 'SHELL': '/bin/bash', 17:24:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fu6iIdRa7O/Listeners', 17:24:03 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 17:24:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:03 INFO - 'USER': 'cltbld', 17:24:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:03 INFO - 'XPC_FLAGS': '0x0', 17:24:03 INFO - 'XPC_SERVICE_NAME': '0', 17:24:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:03 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 17:24:03 INFO - Cleaning up... 17:24:03 INFO - Return code: 0 17:24:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:24: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')]} 17:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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', '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 0x10d177b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee9a4ac570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf55d30>, '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 0x10ce7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4abe8>, '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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 17:24: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:24: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 psutil>=3.1.1 17:24:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q0gZpsfuDE/Render', 17:24:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:03 INFO - 'HOME': '/Users/cltbld', 17:24:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:03 INFO - 'LOGNAME': 'cltbld', 17:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:03 INFO - 'MOZ_NO_REMOTE': '1', 17:24:03 INFO - 'NO_EM_RESTART': '1', 17:24:03 INFO - 'PAGER': '/bin/cat', 17:24:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:03 INFO - 'PWD': '/builds/slave/test', 17:24:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:03 INFO - 'SHELL': '/bin/bash', 17:24:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fu6iIdRa7O/Listeners', 17:24:03 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 17:24:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:03 INFO - 'USER': 'cltbld', 17:24:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:03 INFO - 'XPC_FLAGS': '0x0', 17:24:03 INFO - 'XPC_SERVICE_NAME': '0', 17:24:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:03 INFO - Downloading/unpacking psutil>=3.1.1 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:24:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:07 INFO - Installing collected packages: psutil 17:24:07 INFO - Running setup.py install for psutil 17:24:07 INFO - building 'psutil._psutil_osx' extension 17:24:07 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 17:24:07 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 17:24:07 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 17:24:07 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 17:24:08 INFO - building 'psutil._psutil_posix' extension 17:24:08 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 17:24:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:24:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:24:08 INFO - ^ 17:24:08 INFO - 1 warning generated. 17:24:08 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 17:24:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:08 INFO - Successfully installed psutil 17:24:08 INFO - Cleaning up... 17:24:08 INFO - Return code: 0 17:24:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:09 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 0x10d177b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee9a4ac570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf55d30>, '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 0x10ce7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4abe8>, '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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 17:24:09 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 17:24:09 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 17:24:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q0gZpsfuDE/Render', 17:24:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:09 INFO - 'HOME': '/Users/cltbld', 17:24:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:09 INFO - 'LOGNAME': 'cltbld', 17:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:09 INFO - 'MOZ_NO_REMOTE': '1', 17:24:09 INFO - 'NO_EM_RESTART': '1', 17:24:09 INFO - 'PAGER': '/bin/cat', 17:24:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:09 INFO - 'PWD': '/builds/slave/test', 17:24:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:09 INFO - 'SHELL': '/bin/bash', 17:24:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fu6iIdRa7O/Listeners', 17:24:09 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 17:24:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:09 INFO - 'USER': 'cltbld', 17:24:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:09 INFO - 'XPC_FLAGS': '0x0', 17:24:09 INFO - 'XPC_SERVICE_NAME': '0', 17:24:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:24:09 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 17:24:09 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 17:24:09 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 17:24:09 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 17:24:09 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 17:24:09 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 17:24:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:24:12 INFO - Installing collected packages: mozsystemmonitor 17:24:12 INFO - Running setup.py install for mozsystemmonitor 17:24:12 INFO - Successfully installed mozsystemmonitor 17:24:12 INFO - Cleaning up... 17:24:12 INFO - Return code: 0 17:24:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:24: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')]} 17:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:12 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 0x10d177b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee9a4ac570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf55d30>, '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 0x10ce7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4abe8>, '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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 17:24:12 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 17:24:12 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 17:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q0gZpsfuDE/Render', 17:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:12 INFO - 'HOME': '/Users/cltbld', 17:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:12 INFO - 'LOGNAME': 'cltbld', 17:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:12 INFO - 'MOZ_NO_REMOTE': '1', 17:24:12 INFO - 'NO_EM_RESTART': '1', 17:24:12 INFO - 'PAGER': '/bin/cat', 17:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:12 INFO - 'PWD': '/builds/slave/test', 17:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:12 INFO - 'SHELL': '/bin/bash', 17:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fu6iIdRa7O/Listeners', 17:24:12 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 17:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:12 INFO - 'USER': 'cltbld', 17:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:12 INFO - 'XPC_FLAGS': '0x0', 17:24:12 INFO - 'XPC_SERVICE_NAME': '0', 17:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:12 INFO - Downloading/unpacking jsonschema==2.5.1 17:24:12 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 17:24:12 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 17:24:12 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 17:24:12 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 17:24:12 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 17:24:12 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 17:24:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:24:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:24:15 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 17:24:15 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 17:24:15 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 17:24:15 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 17:24:15 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 17:24:15 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 17:24:15 INFO - Downloading functools32-3.2.3-2.tar.gz 17:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:24:16 INFO - warning: no files found matching '*.txt' 17:24:16 INFO - no previously-included directories found matching 'build' 17:24:16 INFO - no previously-included directories found matching 'dist' 17:24:16 INFO - no previously-included directories found matching '.git*' 17:24:16 INFO - Installing collected packages: jsonschema, functools32 17:24:16 INFO - Running setup.py install for functools32 17:24:16 INFO - warning: no files found matching '*.txt' 17:24:16 INFO - no previously-included directories found matching 'build' 17:24:16 INFO - no previously-included directories found matching 'dist' 17:24:16 INFO - no previously-included directories found matching '.git*' 17:24:16 INFO - Successfully installed jsonschema functools32 17:24:16 INFO - Cleaning up... 17:24:16 INFO - Return code: 0 17:24:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:24: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')]} 17:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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', '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 0x10d177b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee9a4ac570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf55d30>, '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 0x10ce7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4abe8>, '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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 17:24: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:24: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 functools32==3.2.3-2 17:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q0gZpsfuDE/Render', 17:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:16 INFO - 'HOME': '/Users/cltbld', 17:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:16 INFO - 'LOGNAME': 'cltbld', 17:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:16 INFO - 'MOZ_NO_REMOTE': '1', 17:24:16 INFO - 'NO_EM_RESTART': '1', 17:24:16 INFO - 'PAGER': '/bin/cat', 17:24:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:16 INFO - 'PWD': '/builds/slave/test', 17:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:16 INFO - 'SHELL': '/bin/bash', 17:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fu6iIdRa7O/Listeners', 17:24:16 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 17:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:16 INFO - 'USER': 'cltbld', 17:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:16 INFO - 'XPC_FLAGS': '0x0', 17:24:16 INFO - 'XPC_SERVICE_NAME': '0', 17:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:24:16 INFO - Cleaning up... 17:24:16 INFO - Return code: 0 17:24:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:24: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')]} 17:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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', '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 0x10d177b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee9a4ac570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf55d30>, '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 0x10ce7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4abe8>, '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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 17:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:24: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 blobuploader==1.2.4 17:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q0gZpsfuDE/Render', 17:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:16 INFO - 'HOME': '/Users/cltbld', 17:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:16 INFO - 'LOGNAME': 'cltbld', 17:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:16 INFO - 'MOZ_NO_REMOTE': '1', 17:24:16 INFO - 'NO_EM_RESTART': '1', 17:24:16 INFO - 'PAGER': '/bin/cat', 17:24:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:16 INFO - 'PWD': '/builds/slave/test', 17:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:16 INFO - 'SHELL': '/bin/bash', 17:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fu6iIdRa7O/Listeners', 17:24:16 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 17:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:16 INFO - 'USER': 'cltbld', 17:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:16 INFO - 'XPC_FLAGS': '0x0', 17:24:16 INFO - 'XPC_SERVICE_NAME': '0', 17:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:16 INFO - Downloading/unpacking blobuploader==1.2.4 17:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:19 INFO - Downloading blobuploader-1.2.4.tar.gz 17:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:24:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:24:19 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 17:24:19 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 17:24:19 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 17:24:19 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 17:24:19 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 17:24:19 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 17:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:24:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:20 INFO - Downloading docopt-0.6.1.tar.gz 17:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:24:20 INFO - Installing collected packages: blobuploader, requests, docopt 17:24:20 INFO - Running setup.py install for blobuploader 17:24:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:24:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:24:21 INFO - Running setup.py install for requests 17:24:21 INFO - Running setup.py install for docopt 17:24:21 INFO - Successfully installed blobuploader requests docopt 17:24:21 INFO - Cleaning up... 17:24:21 INFO - Return code: 0 17:24:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:21 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 0x10d177b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee9a4ac570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf55d30>, '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 0x10ce7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4abe8>, '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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 17:24:21 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 17:24:21 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 17:24:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q0gZpsfuDE/Render', 17:24:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:21 INFO - 'HOME': '/Users/cltbld', 17:24:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:21 INFO - 'LOGNAME': 'cltbld', 17:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:21 INFO - 'MOZ_NO_REMOTE': '1', 17:24:21 INFO - 'NO_EM_RESTART': '1', 17:24:21 INFO - 'PAGER': '/bin/cat', 17:24:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:21 INFO - 'PWD': '/builds/slave/test', 17:24:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:21 INFO - 'SHELL': '/bin/bash', 17:24:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fu6iIdRa7O/Listeners', 17:24:21 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 17:24:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:21 INFO - 'USER': 'cltbld', 17:24:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:21 INFO - 'XPC_FLAGS': '0x0', 17:24:21 INFO - 'XPC_SERVICE_NAME': '0', 17:24:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:22 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-naKXRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:22 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-rcBKYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:22 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-571ZlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:22 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-KRig1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:22 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-3uZvKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:22 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-or473T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:22 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-IAxWE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:22 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-pTUsL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:22 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-bQFAJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Ync9GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-yh10S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-zfzPqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-H4tWLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ncu2MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gDsrpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-43v40w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ST74PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:24:23 INFO - Running setup.py install for manifestparser 17:24:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:24:23 INFO - Running setup.py install for mozcrash 17:24:24 INFO - Running setup.py install for mozdebug 17:24:24 INFO - Running setup.py install for mozdevice 17:24:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:24:24 INFO - Running setup.py install for mozfile 17:24:24 INFO - Running setup.py install for mozhttpd 17:24:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:24:24 INFO - Running setup.py install for mozinfo 17:24:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:24:24 INFO - Running setup.py install for mozInstall 17:24:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:24:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:24:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:24:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:24:24 INFO - Running setup.py install for mozleak 17:24:25 INFO - Running setup.py install for mozlog 17:24:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:24:25 INFO - Running setup.py install for moznetwork 17:24:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:24:25 INFO - Running setup.py install for mozprocess 17:24:25 INFO - Running setup.py install for mozprofile 17:24:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:24:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:24:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:24:25 INFO - Running setup.py install for mozrunner 17:24:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:24:25 INFO - Running setup.py install for mozscreenshot 17:24:26 INFO - Running setup.py install for moztest 17:24:26 INFO - Running setup.py install for mozversion 17:24:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:24:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:24:26 INFO - Cleaning up... 17:24:26 INFO - Return code: 0 17:24:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:26 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')]} 17:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:26 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')]} 17:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:26 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 0x10d177b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee9a4ac570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf55d30>, '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 0x10ce7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4abe8>, '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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 17:24:26 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 17:24:26 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 17:24:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q0gZpsfuDE/Render', 17:24:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:26 INFO - 'HOME': '/Users/cltbld', 17:24:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:26 INFO - 'LOGNAME': 'cltbld', 17:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:26 INFO - 'MOZ_NO_REMOTE': '1', 17:24:26 INFO - 'NO_EM_RESTART': '1', 17:24:26 INFO - 'PAGER': '/bin/cat', 17:24:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:26 INFO - 'PWD': '/builds/slave/test', 17:24:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:26 INFO - 'SHELL': '/bin/bash', 17:24:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fu6iIdRa7O/Listeners', 17:24:26 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 17:24:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:26 INFO - 'USER': 'cltbld', 17:24:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:26 INFO - 'XPC_FLAGS': '0x0', 17:24:26 INFO - 'XPC_SERVICE_NAME': '0', 17:24:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:26 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-k3V1M9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:26 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)) 17:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:26 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-VlPvc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:26 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)) 17:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:26 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-3l4HOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:27 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)) 17:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-wwVULI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:27 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)) 17:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-oet_zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:27 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)) 17:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-lFyWaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:27 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)) 17:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-FWJXIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:27 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)) 17:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-AJMTCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:27 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)) 17:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-em9y30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:27 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)) 17:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-B2NzTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:27 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)) 17:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-pzDSwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:27 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)) 17:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-dGd1ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:27 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)) 17:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:27 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gH_DXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:28 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)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-IDkz_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:28 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)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ZSen6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:28 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)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Qw83Dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:28 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)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-cKfIvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 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)) 17:24:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:24:28 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 17:24:28 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 17:24:28 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 17:24:28 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 17:24:28 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 17:24:28 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 17:24:31 INFO - Downloading blessings-1.6.tar.gz 17:24:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:24:31 INFO - Installing collected packages: blessings 17:24:31 INFO - Running setup.py install for blessings 17:24:31 INFO - Successfully installed blessings 17:24:31 INFO - Cleaning up... 17:24:31 INFO - Return code: 0 17:24:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:24:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:24:31 INFO - Reading from file tmpfile_stdout 17:24:31 INFO - Current package versions: 17:24:31 INFO - blessings == 1.6 17:24:31 INFO - blobuploader == 1.2.4 17:24:31 INFO - docopt == 0.6.1 17:24:31 INFO - functools32 == 3.2.3-2 17:24:31 INFO - jsonschema == 2.5.1 17:24:31 INFO - manifestparser == 1.1 17:24:31 INFO - mozInstall == 1.12 17:24:31 INFO - mozcrash == 1.0 17:24:31 INFO - mozdebug == 0.1 17:24:31 INFO - mozdevice == 0.50 17:24:31 INFO - mozfile == 1.2 17:24:31 INFO - mozhttpd == 0.7 17:24:31 INFO - mozinfo == 0.9 17:24:31 INFO - mozleak == 0.1 17:24:31 INFO - mozlog == 3.4 17:24:31 INFO - moznetwork == 0.27 17:24:31 INFO - mozprocess == 0.25 17:24:31 INFO - mozprofile == 0.28 17:24:31 INFO - mozrunner == 6.13 17:24:31 INFO - mozscreenshot == 0.1 17:24:31 INFO - mozsystemmonitor == 0.3 17:24:31 INFO - moztest == 0.8 17:24:31 INFO - mozversion == 1.4 17:24:31 INFO - psutil == 3.1.1 17:24:31 INFO - requests == 1.2.3 17:24:31 INFO - wsgiref == 0.1.2 17:24:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:31 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')]} 17:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:31 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')]} 17:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:31 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 0x10d177b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee9a4ac570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf55d30>, '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 0x10ce7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4abe8>, '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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 17:24:31 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 17:24:31 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 17:24:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q0gZpsfuDE/Render', 17:24:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:31 INFO - 'HOME': '/Users/cltbld', 17:24:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:31 INFO - 'LOGNAME': 'cltbld', 17:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:31 INFO - 'MOZ_NO_REMOTE': '1', 17:24:31 INFO - 'NO_EM_RESTART': '1', 17:24:31 INFO - 'PAGER': '/bin/cat', 17:24:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:31 INFO - 'PWD': '/builds/slave/test', 17:24:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:31 INFO - 'SHELL': '/bin/bash', 17:24:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fu6iIdRa7O/Listeners', 17:24:31 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 17:24:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:31 INFO - 'USER': 'cltbld', 17:24:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:31 INFO - 'XPC_FLAGS': '0x0', 17:24:31 INFO - 'XPC_SERVICE_NAME': '0', 17:24:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:31 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)) 17:24:31 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)) 17:24:31 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)) 17:24:31 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)) 17:24:31 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)) 17:24:31 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)) 17:24:31 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)) 17:24:31 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)) 17:24:31 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)) 17:24:31 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)) 17:24:31 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)) 17:24:31 INFO - Cleaning up... 17:24:31 INFO - Return code: 0 17:24:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:24:31 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')]} 17:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:31 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')]} 17:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:31 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 0x10d177b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee9a4ac570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf55d30>, '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 0x10ce7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4abe8>, '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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 17:24:31 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 17:24:31 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 17:24:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q0gZpsfuDE/Render', 17:24:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:31 INFO - 'HOME': '/Users/cltbld', 17:24:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:31 INFO - 'LOGNAME': 'cltbld', 17:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:31 INFO - 'MOZ_NO_REMOTE': '1', 17:24:31 INFO - 'NO_EM_RESTART': '1', 17:24:31 INFO - 'PAGER': '/bin/cat', 17:24:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:31 INFO - 'PWD': '/builds/slave/test', 17:24:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:31 INFO - 'SHELL': '/bin/bash', 17:24:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fu6iIdRa7O/Listeners', 17:24:31 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 17:24:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:31 INFO - 'USER': 'cltbld', 17:24:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:31 INFO - 'XPC_FLAGS': '0x0', 17:24:31 INFO - 'XPC_SERVICE_NAME': '0', 17:24:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:24:32 INFO - Cleaning up... 17:24:32 INFO - Return code: 0 17:24:32 INFO - Running post-action listener: _resource_record_post_action 17:24:32 INFO - Running post-action listener: _start_resource_monitoring 17:24:32 INFO - Starting resource monitoring. 17:24:32 INFO - [mozharness: 2017-04-13 00:24:32.280567Z] Finished create-virtualenv step (success) 17:24:32 INFO - [mozharness: 2017-04-13 00:24:32.281491Z] Running install step. 17:24:32 INFO - Running pre-action listener: _resource_record_pre_action 17:24:32 INFO - Running main action method: install 17:24:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:24:32 INFO - Reading from file tmpfile_stdout 17:24:32 INFO - Detecting whether we're running mozinstall >=1.0... 17:24:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:24:32 INFO - Reading from file tmpfile_stdout 17:24:32 INFO - Output received: 17:24:32 INFO - Usage: mozinstall [options] installer 17:24:32 INFO - Options: 17:24:32 INFO - -h, --help show this help message and exit 17:24:32 INFO - -d DEST, --destination=DEST 17:24:32 INFO - Directory to install application into. [default: 17:24:32 INFO - "/builds/slave/test"] 17:24:32 INFO - --app=APP Application being installed. [default: firefox] 17:24:32 INFO - mkdir: /builds/slave/test/build/application 17:24:32 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'] 17:24:32 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 17:24:52 INFO - Reading from file tmpfile_stdout 17:24:52 INFO - Output received: 17:24:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:24:52 INFO - Running post-action listener: _resource_record_post_action 17:24:52 INFO - [mozharness: 2017-04-13 00:24:52.244962Z] Finished install step (success) 17:24:52 INFO - [mozharness: 2017-04-13 00:24:52.245090Z] Running run-tests step. 17:24:52 INFO - Running pre-action listener: _resource_record_pre_action 17:24:52 INFO - Running main action method: run_tests 17:24:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:24:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:24:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:24:52 INFO - 2017-04-12 17:24:52.259 screenresolution[1635:7423] starting screenresolution argv=screenresolution get 17:24:52 INFO - 2017-04-12 17:24:52.262 screenresolution[1635:7423] Display 0: 1600x1200x32@60 17:24:52 INFO - 2017-04-12 17:24:52.268 screenresolution[1636:7426] starting screenresolution argv=screenresolution list 17:24:52 INFO - Available Modes on Display 0 17:24:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:24:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:24:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:24:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:24:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:24:52 INFO - Intel Iris: 17:24:52 INFO - Chipset Model: Intel Iris 17:24:52 INFO - Type: GPU 17:24:52 INFO - Bus: Built-In 17:24:52 INFO - VRAM (Dynamic, Max): 1536 MB 17:24:52 INFO - Vendor: Intel (0x8086) 17:24:52 INFO - Device ID: 0x0a2e 17:24:52 INFO - Revision ID: 0x0009 17:24:52 INFO - Displays: 17:24:52 INFO - Display: 17:24:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:24:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:24:52 INFO - Display Serial Number: 1600x1200 60 17:24:52 INFO - Main Display: Yes 17:24:52 INFO - Mirror: Off 17:24:52 INFO - Online: Yes 17:24:52 INFO - Rotation: Supported 17:24:52 INFO - Return code: 0 17:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:24:52 INFO - Python 2.7.3 17:24:52 INFO - Return code: 0 17:24:52 INFO - grabbing minidump binary from tooltool 17:24:52 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')]} 17:24:52 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 0x10cf55d30>, '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 0x10ce7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:24:52 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 17:24:52 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 17:24:52 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 17:24:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:24:52 INFO - Return code: 0 17:24:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:24:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:24:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:24:52 INFO - ENV: RUST_BACKTRACE is now 1 17:24:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:24:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q0gZpsfuDE/Render', 17:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:52 INFO - 'HOME': '/Users/cltbld', 17:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:52 INFO - 'LOGNAME': 'cltbld', 17:24:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:24:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:52 INFO - 'MOZ_NO_REMOTE': '1', 17:24:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:24:52 INFO - 'NO_EM_RESTART': '1', 17:24:52 INFO - 'PAGER': '/bin/cat', 17:24:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:52 INFO - 'PWD': '/builds/slave/test', 17:24:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:52 INFO - 'RUST_BACKTRACE': '1', 17:24:52 INFO - 'SHELL': '/bin/bash', 17:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fu6iIdRa7O/Listeners', 17:24:52 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 17:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:52 INFO - 'USER': 'cltbld', 17:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:52 INFO - 'XPC_FLAGS': '0x0', 17:24:52 INFO - 'XPC_SERVICE_NAME': '0', 17:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:24:52 INFO - mozversion application_buildid: 20170412155613 17:24:52 INFO - mozversion application_changeset: c7159022ffd95b4faa3a19a1796bc782312bc045 17:24:52 INFO - mozversion application_display_name: Nightly 17:24:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:24:52 INFO - mozversion application_name: Firefox 17:24:52 INFO - mozversion application_remotingname: firefox 17:24:52 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 17:24:52 INFO - mozversion application_vendor: Mozilla 17:24:52 INFO - mozversion application_version: 55.0a1 17:24:52 INFO - mozversion platform_buildid: 20170412155613 17:24:52 INFO - mozversion platform_changeset: c7159022ffd95b4faa3a19a1796bc782312bc045 17:24:52 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 17:24:52 INFO - mozversion platform_version: 55.0a1 17:24:52 INFO - using testdate: 1492043092 17:24:52 INFO - actual date: 1492043092 17:24:52 INFO - starting webserver on 'localhost:49241' 17:24:52 INFO - SUITE-START | Running 2 tests 17:24:52 INFO - TEST-START | dromaeo_css 17:24:52 INFO - operating with platform_type : mac_ 17:24:52 INFO - Initialising browser for dromaeo_css test... 17:24:52 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpoPCe1b/profile http://localhost:49241/getInfo.html) 17:24:55 INFO - PID 1646 | __metrics Screen width/height:1600/1200 17:24:55 INFO - PID 1646 | colorDepth:24 17:24:55 INFO - PID 1646 | Browser inner width/height: 1024/689 17:24:55 INFO - PID 1646 | __metrics 17:24:56 INFO - PID 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:24:56 INFO - PID 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:24:56 INFO - TEST-INFO | 1646: exit 0 17:24:56 INFO - Browser initialized. 17:24:56 INFO - Running cycle 1/1 for dromaeo_css test... 17:24:56 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpoPCe1b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:09 INFO - PID 1648 | RSS: Main: 241274880 17:25:09 INFO - PID 1648 | 17:28:14 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 17:28:15 INFO - PID 1648 | RSS: Main: 377012224 17:28:15 INFO - PID 1648 | 17:29:58 INFO - PID 1648 | ************************* 17:29:58 INFO - PID 1648 | A coding exception was thrown and uncaught in a Task. 17:29:58 INFO - PID 1648 | 17:29:58 ERROR - PID 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:29:58 INFO - PID 1648 | Full stack: 17:29:58 INFO - PID 1648 | ************************* 17:29:58 INFO - PID 1648 | ************************* 17:29:58 INFO - PID 1648 | A coding exception was thrown and uncaught in a Task. 17:29:58 INFO - PID 1648 | 17:29:58 ERROR - PID 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:29:58 INFO - PID 1648 | Full stack: 17:29:58 INFO - PID 1648 | ************************* 17:29:58 INFO - PID 1648 | ************************* 17:29:58 INFO - PID 1648 | A coding exception was thrown and uncaught in a Task. 17:29:58 INFO - PID 1648 | 17:29:58 ERROR - PID 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:29:58 INFO - PID 1648 | Full stack: 17:29:58 INFO - PID 1648 | ************************* 17:29:58 INFO - PID 1648 | ************************* 17:29:58 INFO - PID 1648 | A coding exception was thrown and uncaught in a Task. 17:29:58 INFO - PID 1648 | 17:29:58 ERROR - PID 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:29:58 INFO - PID 1648 | Full stack: 17:29:58 INFO - PID 1648 | ************************* 17:31:18 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 17:31:19 INFO - PID 1648 | RSS: Main: 371884032 17:31:19 INFO - PID 1648 | 17:34:21 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 17:34:21 INFO - PID 1648 | RSS: Main: 327761920 17:34:21 INFO - PID 1648 | 17:37:24 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 17:37:24 INFO - PID 1648 | RSS: Main: 323198976 17:37:24 INFO - PID 1648 | 17:40:28 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 17:40:29 INFO - PID 1648 | RSS: Main: 334655488 17:40:29 INFO - PID 1648 | 17:43:31 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 17:43:31 INFO - PID 1648 | RSS: Main: 379707392 17:43:31 INFO - PID 1648 | 17:43:31 INFO - PID 1648 | __start_tp_report 17:43:31 INFO - PID 1648 | _x_x_mozilla_page_load 17:43:31 INFO - PID 1648 | _x_x_mozilla_page_load_details 17:43:31 INFO - PID 1648 | |i|pagename|runs| 17:43:31 INFO - PID 1648 | |0;dojo.html;3056.786024978251;3496.230829217571;3498.7201023918083;3537.6285490023547;3559.804210768408;6073.635581865091;6115.60544095844;6212.813615591534;6232.594881332716;6246.781362652308;5209.791608335662;6070.54470914682;6145.494353883294;6145.784897528587;6243.063540468932;5271.630985830974;5353.5984801139975;5354.544863686591;5387.111126664116;5529.281193444846;5494.890102197954;5500.367457742351;5500.50495455409;5500.889982200353;5501.4223506531835;5272.894542109175;5382.91925621116;5383.623146379755;5390.460953904618;5460.7542660580175;5390.029794636964;5404.216388623628;5408.8377348679605;5466.835994920159;5483.985462689376;5363.222332761728;5369.785208591652;5370.946290537123;5378.811741589065;5417.918731219035;6049.48579370754;6117.541184411187;6142.539309551757;6155.784547540815;6167.321594624633;5899.1446240295345;6338.809835704937;6397.616143031387;6481.449076828475;6571.44142747867;6649.102371179877;6651.334866513358;6660.167479065117;6661.666916654196;6678.065070890079;6136.294326152461;6185;6245.000799871998;6246.375362463808;6250.6874656267;6505.316941721051;6605.24039735427;6643.933560664332;6696.8995465068065;6801.1838579369805;6447.742090316428;6454.225492940784;6456.418922297016;6459.709313080923;6477.417032467007;5541.944580554224;6514.54398192122;6636.203655561363;6636.435902948207;6660.23407308156;6301.558890877686;6352.237731472253;6361.809145725636;6477.093206951031;6551.836204094936;6480.708368123445;6530.249021362604;6535.901961470582;6556.967215163893;6567.211934567882;5284.128118860345;5303.708296043755;5310.468953104736;5315.335583052119;5349;4175.8956026099595;4649.418822647169;4683.1336202802595;4699.083678682692;4734.053189362141;5898.8230353089475;6146.4775494082605;6188.8762224755255;6231.750729970841;6234.2830574484515;6603.339666033358;6604.1084453599115;6607.240167380716;6608.471322294301;6639.734410623521;6198.246286678856;6238.157848690459;6250.124982502453;6251.3123556408755;6259.874802503924;5701.315842098892;5757.280339957505;5774.538036957033;5777.653340799566;5854.736536855852;6775.525713200029;6783;6785.626790526569;6788.9660551696925;6793.5244532882225;6390.808275751735;6421.8715625688155;6466;6555.016747487724;6659.467242620675;6728.158980127484;6746.4940129489505;6750.25747167821;6750.696218670073;6758.662066896733;6317.210348706411;6510.283868774336;6511.3163117871945;6517.967410162919;6523.151990241238;6383.872322553616;6468.126802881551;6556.147700799056;6605.834854128685;6624.271330153583;6368.172137622079;6383.0744542042075;6390.616563006234;6396.520260980538;6434.581752186093;6406;6416.390442907917;6425.742970281136;6434.967825160844;6439.356064393523;6228.34602366745;6270.278917924497;6273.99616061428;6274.341194174728;6310.463610593151;6417.935820641734;6440.227172739301;6440.2915679276175;6462.159919210472;6466.708998095003;6281.466075383643;6316.147320111726;6334.493240540838;6336.809895703136;6345.302016778059 17:43:31 INFO - PID 1648 | |1;ext.html;706.4524993130324;759.2217976574011;814.682273913174;1145.410113791397;1158.6176561734628;27692.58461123082;36232.45651315229;36917.446238306446;37062.258754824885;37121.886343409744;38393;38622.42066369006;38778;38789.418158727574;38835.61164388355;6112.572119951606;7125.465590080738;8678.132186781302;8687.56562171892;8705.477671339708;6186.969065154668;8310.875336869953;8512.106228845974;8532.914670853304;8551.016633087213;8545;8560.229579337889;8582.78543036426;8584.957075214616;8585.441946273504;8503.107173746761;8555.10171431997;8569.442986205877;8573.22840944318;8603.053664096975;8467.872981905277;8504.192101750325;8518.488890666518;8519.701810436605;8534.274586660142;37215.627843721486;37400;37505.812470937744;37523.24953500942;37676.246475070344;3573.5890372607223;3610.7472476926628;3618.203995121069;3623.3296840084404;3628.2924829658227;30535.389292214255;30646.62090205924;30652.8467357664;30666;30683;3134.059782065394;3175.1268401189627;3181.984090079558;3190.058932614861;3202.071399294225;234389;236892;237712;239331;240037;48535;48695.756521217874;48755.781105471935;48805.26792098121;48866.75566622144;49963;49998.25002624963;50025.24962125571;50040.74979625151;50057;14417.92791036038;14521.491747788778;14539.054961427684;14543.854561454462;14544.27278636064;10258.538365773558;10390.428526430967;11923.046156307648;11931.463084161234;11951.103667224992;11147.38689372076;11247.83128253077;11278.436078196057;11297;12354.320512371725;4676.392069031072;5013.323201367842;5158.74206289684;5281.15501519755;5282.577393808486;965.6137544982064;1049.994750026245;1053.599632139782;1073.436445865911;1077.5528155815248;22475.775242247695;22993.655095173584;23090.884545577166;24351.75648243495;24440.06719193708;1101.7245688577855;1111.5887121765;1132.0321125437797;1170.2627344772739;1173.6889724223088;12119.515219391125;12465.75068498625;16356.754648680278;16377.0992595406;16527.559211967822;314622;316954;317110;318283;318439;54634;54659;54750.45249547533;54793.452065478836;55217;1499.640086379283;1526.8167819861465;1546.4819285539245;1546.7525195968592;1555.3389809330988;28532.42935141327;29004.08444859917;29403.55894661539;29423.411531768816;29426.558601620563;37986.050348741504;38053.23893522169;38067.61932380641;38074.42888356732;38099.238015240095;280312.5984370065;280324;280878;281000;281416;26200.213993580222;32976.34047318992;33577.83211083929;34818.47772283367;35003.77486788052;37925.81037094797;38261;38634.22731545297;45213.54786452094;45366.31950520679;24894.270004412734;28761.856190718914;30855.69144308618;31752.841235793672;32152;30597.847010764803;31126.844365778026;31237.687623124388;31325;31874.362512750078;35505.1123721909;36545;37271.254574907805;37314;37811.81094094512;30722;31404.685953140175;31637.683623163473;32087.67912320847;32135.357292854478;19764.0825711;21799.91000450003;23602.17392391258;24377.63433548463;24437.75562244426 17:43:31 INFO - PID 1648 | |2;jquery.html;436.4260996789224;439.82626862389355;439.85484790019296;447.14818271193377;460.4083752378195;16051.75922361164;21437.67843482349;21986.01062952167;22192.8890355548;22254.666180007313;21631.134754609797;22628.660570091422;23183.420414489647;23517.647235291442;23599.05603775847;6024.518038556916;6035.215421995134;6228.5951413158;6232.563720539564;6255.812325630239;5978.461938425541;6211.347808480113;6235.127082208494;6244.06339049144;6250.000000000001;5845.567835880215;5971.343152253248;6192.721327540249;6200.78297259596;6205.3484384139465;6048.123022161784;6181.845453863644;6182.783602573933;6183.010718285075;6186.876262474771;4788.162071637485;5423.2949716537;5470.91793623096;5477;5490.423505531941;27630.75661595233;27645.86177069102;27684.584731229046;27750.3062423439;28021.859890700416;2199.8900054997184;2265.569541787055;2265.728112626479;2268.7958083772373;2271.159670921753;17747.911260443743;17889.600975814552;18236.270549178018;18238.08809559517;18393.172307246205;2134.4343748906554;2146.9570608587896;2208.9447763806033;2209.7900699433526;2216.711827462436;144052;144546.27726861404;145210.7662773951;146162.26918865443;159520.83354165213;10589.046985771318;11762.000229980376;11795;12297.44661490235;12427.254364738144;16352.75470867938;16374.508764736838;16382.0170789753;16382.918085409498;16406.589835254214;8226.84824124623;8529.402941794015;8925.062868398725;9158;9255.583498742573;8533.232009119085;8864.822703545893;8871.379003469696;9068.54657267134;9084.955230148618;6825.897611535831;7659.808504787425;7803.375729941591;7828;7851.332636725828;1955.4036019014052;2029.1883246701143;2145.781328007988;2162.3729118555757;2320.6519022146813;962.9215278887691;974.8732664753537;992.4690290694443;1023.698009087321;1025.4923812712755;19964.201431942558;20793.480162995744;21080.894595526923;21164.47088822792;21419.92900354976;989.1641562879355;993.7465946183677;1024.3700124423426;1031.9071283584512;1033.4884232305058;10568.048875601233;10874.130069594414;10953.397563133945;10974.670759877217;10978.560857565768;664994;666613;667670;681511;682839;100914;118691.40654296674;122159.3948574884;125005;149219;1149.683836944847;1206.312401930891;1237.9381030948596;1241.596481143632;1245.9875401245872;19603.197216682005;21866.89066554657;22126.783026933674;22356.888215558818;22609.886950565142;62376.688116559126;63400;63528.682356587924;64119.358806411336;64161.67919160374;87087.56456217679;87667.56166219128;87903.56048219718;88060.5596972011;88771;8657.567121643766;8780.560971951505;8808.075152108937;8977.865332020156;9145.039770823967;13454.192748435125;13547.729045419233;13571.321433928462;13942.163470191821;14057.718845622825;12011.339376334385;12121.636350909486;12281.815772763237;12397.256164630151;12470.875291246972;11401.144914131308;11578.363190024293;11633.767324653629;11926.344051077274;11956.820647690118;10195.286329956833;11786.58746943853;11886.82169767437;11983;12293;8840.557972101498;9038.276937844825;9074.954625226832;9093.77265568366;9103.817923641622;10105;11737.530498779954;11915.940420297842;12158.574449894211;12303.261804291771 17:43:31 INFO - PID 1648 | |3;mootools.html;1361.666391734025;1411.9011669183155;1443.4731323067076;1444.617176448241;1451.920144392058;11555.942220288898;12101.031917446606;12114.515419383226;12114.878851211486;12153;11615.47730352134;11806.645800625973;12015.759684806299;12053.638390848266;12072;2524.0660955446465;2567.6020216866414;2571.061562529682;2571.819972601919;2577.6133579962966;2108.2937216032647;2494.87525623719;2541.936451588716;2542.288159315385;2544.7200807911113;1987.3839109875912;2535.8985640574356;2538.3146550431375;2544.414784599543;2546.9235922922344;2437.122635851092;2438.7683170098812;2455.2143314139485;2462.4336402627405;2468.469279105001;2109.947251318714;2115;2513.1204078572537;2516;2521.8360806547516;9810;11798.823017654742;11939.34333611651;11943.462544185533;11960.820587691192;6342.746290148389;6468.1268028815975;6481.28705842357;6529.5429319947625;6813.284605116441;4105.815238314253;4241.34259189826;4269.295566231568;4332.1985432695055;4344.131173765228;1213.1172032568893;1239.095460313967;1270.491803278696;1278.3735969375032;1295.1452041652465;15274.465393711278;15735.291911863993;15744.370225190978;16767.413140540022;17000.3199872005;5207.4011488678525;5284.497972692588;5532.6680399176175;5614.747336369873;5834.912476312858;12505.812412813815;12531.93734031324;12539.310337931502;12560.371981400893;12566.497340106476;5807.651540907559;6055.969720151459;6420.165378500765;6680.365365290289;6714.261431242559;6064.939350606437;6245.968770156211;6258.155149054819;6269.7178626961895;6273.466755325757;4387.5868272450025;4416.779161041935;4476;4513.954860451419;4519.525449827786;1302.2316833068535;1304.4651692806094;1307.2613973105165;1325.4035683942266;1329.5707114851573;794.8648729715846;797.0674311056079;802.8193656427258;814.608987685914;839.072824528899;6063.363346848606;6069.180660610849;6293.811185664437;6301.14934483848;6418.807435776934;587.2277954489832;596.773226174051;600.3276330509857;603.9063945088518;610.3073012131263;3610.8375123119;3781.6029316921877;3878.534575850916;3890.630390112935;3937.8818635440985;14532.346044428026;15186.24068796578;15337.769933451007;15613.765793513106;15615;15029.924850375679;15283.541493755205;15511.92244038795;15548.678362339328;15562.455314063953;10998.091232127112;11034.289685098822;11074.723131921766;11199.272047317061;11349.148813838996;5652.152177173457;6966.616836074065;7210.855782884418;7225.1329840419485;7238.312360325761;13172.736545269232;13229.272390018641;13272.469101235842;13644.113132646346;13667.726645466835;11265.71835704114;11476.4261786912;14015.159090454605;14221.857781422466;14352;8623.82752344937;8668.913310867063;8704.738857834274;8746.737597872074;8809.11908809114;10743.301685390425;10856.402897840695;10866.945665271624;10869.619563315246;10876.184286178726;7808.258215469521;9024;9275.67535136267;9276.350655454324;9344.112309330603;9051.728448146303;9091.681791137278;9181.357304988587;9182.17360437564;9274.860877086714;8047.51714897108;8289.253967142986;8343.666253349798;8360.83278334442;8373.748787536384;6024.638521688713;6025.216721826135;6050.183225264709;6092.903277410109;6281.214848143982;5438.537724293479;5857.9121313179485;5871.354151043467;6116.418940200674;6203.100550420254 17:43:31 INFO - PID 1648 | |4;prototype.html;397.9621935916088;404.82794812204804;405.0966345050539;405.50325850832735;412.86994596702056;4842.733649649268;5842.766289348427;5910.202122713433;5948.167256584071;5975.103734439831;4538.341940418637;5667.886642267152;5723.341815691187;5837.591368604189;5845.895477628061;3635.690966267857;4454.754988475633;4471.888202794924;4493.4832494263255;4518.819247230107;3855.9807200964096;4380.890477738066;4488.932666010012;4509.571590698878;4523.977380113111;3867.5358956925206;4377.467886239822;4436.29019356903;4467.352233926079;4477;4434.711743736663;4438.755868427235;4463.665919226525;4464.129494748526;4471.955280447187;3959.1487830116375;3983.721139520235;3989.842945545788;4023.499555386803;4030;5380.596455265871;5672.290963629546;5767.452092051249;5798.246227990377;5798.536117110621;5353.544948679367;5391.433899440581;5393.487618676219;5401.891962160774;5432.891342173134;6210.285817130997;6227.283862355842;6267.435930766253;6301.275353334379;6305.076951529782;4339.566043395666;4480.6191473724775;4505.707129036602;4521.892136426596;4601.378813860119;6244.687765611747;6417.550771446001;6462.935370646233;6468.902966455507;6481.805545833632;3893;4546.363309208682;4618.607418369409;4643.419572553431;4645.744484053342;4450.954025803933;4538.773061346919;4719.622430205575;4738.336632871401;4779.354787103766;5158.174692049254;5173.405058418255;5305.761240744176;5322.3879253885525;5340.786368545292;6283.277423096311;6289.182406287154;6300.30696623371;6301.275353334334;6325.715342809584;1531.6783475470054;1607.3008241415023;1607.694538037769;1611.6212690017837;1626.9349226031063;1104.5471356743858;1116.4975760907462;1133.5749094089717;1136.9374684392437;1145.381493993251;4758.904821903542;4801.399825021872;4896.36347274852;5657.321121465368;5732.824770921951;5513.724313784375;6294.685265736694;6334.334894835976;6407.967960160169;6453.870922581522;5526.50261476469;5742.913856292159;5750.683712395775;5793.290979161157;5893.793717219963;2938.2507460597412;2955.4089182163652;3301.4882693182594;3350.8272104763137;3373.3807772269447;5925.792597259076;6410.583312084699;6514.902276465857;6594.241662208811;6672.165979252593;5409.56723462122;6482.189726284215;6602.537822352485;6623.370779775913;6659.500537459709;5415.783368665288;6572.901406478811;6580.078788969548;6585.868282634417;6610.041543976096;5057.848264552069;6020.849478763066;6403.295637479967;6433.420992110732;6444.323346048597;5424.915016996695;6007;6077.331493535619;6338.176037115146;6343.4608058313715;5581.5255703265675;5647.29408823897;5754.108113242454;5761.971190144022;6372.267189273293;4106.7946602670345;4149.149424367937;4186.434831297857;4292.570742925683;4320.848770293024;5814.30228372598;6169.784057557964;6345;6462.192225971754;6477.708503117276;6184;6196.783112591038;6220.657863817352;6225.315215326401;6244.281907580505;5072.036313100647;5988.910166347596;6064.818055458167;6151.200343955257;6187.978983467858;5998.640081595118;6002.399760024137;6026.548008899438;6045.153678485103;6076.453119219292;5557.694326812064;5787.305523337226;6005.489533389711;6074.574779765374;6239.4696450800375;5491.945080549303;5870.708444142282;5943.465088142088;6032.90950635732;6081.14186332423 17:43:31 INFO - PID 1648 | |5;yui.html;713.0302788208033;797.9601019949002;864.4813112132721;871.5729292646605;882.9470231786094;13495.662608434783;18164.455066348015;18809.529761755963;18863.15115819788;18933.81066189336;17614;17643.294268229256;18019.729704054418;18093.4571962841;18104.456866294033;980.127686359141;1000.3397757480064;1002.413588050991;1004.231762701534;1004.5379125602232;671.942884854788;689.4139981016147;693.3309356471004;1017.5777052523194;1025.0927928783044;741.388354607451;743.5650144665377;893.2452077994085;1016.374929418406;1060.6499855047816;1046.7278507588082;1047.8952104789498;1049.5854137615675;1050.7268110291302;1051.526812934179;778.3500776851336;778.4861991085857;780.028864064238;782.1435528096782;784.6508303804809;16495.257713402807;16735.581610459714;16874.83125168745;17039.744403833953;17432.302707891668;16762.74855877163;16946.83053169465;17347.479575612753;17366.131693415406;17396.56508587283;13784.862151378458;13990.950678699139;13991.930040349733;13998.230097344642;14100.788488172686;3445.9655403445895;3457.2739724657854;3462.3940810358085;3467.9826600866836;3477.7739446935866;84331;104331.56684331506;104764.95235047628;105285.47357263241;106330;11996;12121.39393030345;12182.147249692614;13033.348332583333;13423.261720605266;24916.75083249144;25193.244202673948;25387;25630.359241019123;25776.613350799755;8981.955090224637;9034.23209027227;9135.360524763202;9232.21526170283;9238.76903077415;4824.204006338915;4919.3358896549225;4921.089598424303;4924.729139897268;4928.950710492921;4294.9785251073545;4333.198358303661;4424.181526417623;4425.468943726709;4431.645468362523;939.9859002114973;963.3786207895868;964.9324547281764;965.6909788867495;968.4383057826444;654.6334052930374;655.5476721062452;666.3869240298936;671.7615246587488;701.8491024429773;9334.299927505464;9469.621215151317;10743.83884241737;11581.652550423501;11871.169018168817;649.490150232075;667.2693400726197;669.4644284572323;680.4760334542375;691.8097523181166;5382.381026181961;5487.945120548823;5515.4760297771645;5544.3346798383645;5622.718864056863;108701;109297.45351273351;112411.43794280976;114748;115023.42488287673;88801;88906;89029.55485222532;90061.19015597788;90517;71778.97547171752;73045.6347718258;75462.6226868873;76125;77265.6136719324;12053;12289.754204916031;12450.25298482094;12564.371781411075;12630.565631404112;37940.62059379371;38290.61709382982;38535.42196866993;38781.80609096937;39471.013224669616;51631.48368516267;52442.68893277546;52714.945701084995;52834.73582632062;52906.47093529169;15537.22313884324;15789.002773662905;15856.048637081813;15903.840961590698;16023.439179628656;17545.298188072335;17586.38447654326;17640.91179544094;17783.73324400161;17947.833390830077;16108.27512761905;16310.429134980219;16334.428295010093;16379.59051023734;16483.67032659364;15751.842481575037;15864.60338491547;16180.514584562481;16213.35146594123;16302.755458668367;15384.769228461806;15582.376704931676;15659.921700391425;15672.608184795472;15901;11604.361760103275;11797.469113889723;11880.643580692593;11969.940150299193;12032.398380080786;12270.693232668898;12311.445984930879;12326.50693972231;12354.622880151122;12529.18560293578 17:43:31 INFO - PID 1648 | __end_tp_report 17:43:31 INFO - PID 1648 | __start_cc_report 17:43:31 INFO - PID 1648 | _x_x_mozilla_cycle_collect,1455 17:43:31 INFO - PID 1648 | __end_cc_report 17:43:31 INFO - PID 1648 | __startTimestamp1492044211821__endTimestamp 17:43:31 INFO - PID 1648 | 17:43:31 INFO - PID 1648 | ------- Summary: start ------- 17:43:31 INFO - PID 1648 | Number of tests: 6 17:43:31 INFO - PID 1648 | 17:43:31 INFO - PID 1648 | [#0] dojo.html Cycles:165 Average:6060.12 Median:6301.56 stddev:704.17 (11.2%) stddev-sans-first:665.75 17:43:31 INFO - PID 1648 | Values: 3056.8 3496.2 3498.7 3537.6 3559.8 6073.6 6115.6 6212.8 6232.6 6246.8 5209.8 6070.5 6145.5 6145.8 6243.1 5271.6 5353.6 5354.5 5387.1 5529.3 5494.9 5500.4 5500.5 5500.9 5501.4 5272.9 5382.9 5383.6 5390.5 5460.8 5390.0 5404.2 5408.8 5466.8 5484.0 5363.2 5369.8 5370.9 5378.8 5417.9 6049.5 6117.5 6142.5 6155.8 6167.3 5899.1 6338.8 6397.6 6481.4 6571.4 6649.1 6651.3 6660.2 6661.7 6678.1 6136.3 6185.0 6245.0 6246.4 6250.7 6505.3 6605.2 6643.9 6696.9 6801.2 6447.7 6454.2 6456.4 6459.7 6477.4 5541.9 6514.5 6636.2 6636.4 6660.2 6301.6 6352.2 6361.8 6477.1 6551.8 6480.7 6530.2 6535.9 6557.0 6567.2 5284.1 5303.7 5310.5 5315.3 5349.0 4175.9 4649.4 4683.1 4699.1 4734.1 5898.8 6146.5 6188.9 6231.8 6234.3 6603.3 6604.1 6607.2 6608.5 6639.7 6198.2 6238.2 6250.1 6251.3 6259.9 5701.3 5757.3 5774.5 5777.7 5854.7 6775.5 6783.0 6785.6 6789.0 6793.5 6390.8 6421.9 6466.0 6555.0 6659.5 6728.2 6746.5 6750.3 6750.7 6758.7 6317.2 6510.3 6511.3 6518.0 6523.2 6383.9 6468.1 6556.1 6605.8 6624.3 6368.2 6383.1 6390.6 6396.5 6434.6 6406.0 6416.4 6425.7 6435.0 6439.4 6228.3 6270.3 6274.0 6274.3 6310.5 6417.9 6440.2 6440.3 6462.2 6466.7 6281.5 6316.1 6334.5 6336.8 6345.3 17:43:31 INFO - PID 1648 | 17:43:31 INFO - PID 1648 | [#1] ext.html Cycles:180 Average:43262.01 Median:32111.52 stddev:73407.66 (228.6%) stddev-sans-first:73544.05 17:43:31 INFO - PID 1648 | Values: 706.5 759.2 814.7 1145.4 1158.6 27692.6 36232.5 36917.4 37062.3 37121.9 38393.0 38622.4 38778.0 38789.4 38835.6 6112.6 7125.5 8678.1 8687.6 8705.5 6187.0 8310.9 8512.1 8532.9 8551.0 8545.0 8560.2 8582.8 8585.0 8585.4 8503.1 8555.1 8569.4 8573.2 8603.1 8467.9 8504.2 8518.5 8519.7 8534.3 37215.6 37400.0 37505.8 37523.2 37676.2 3573.6 3610.7 3618.2 3623.3 3628.3 30535.4 30646.6 30652.8 30666.0 30683.0 3134.1 3175.1 3182.0 3190.1 3202.1 234389.0 236892.0 237712.0 239331.0 240037.0 48535.0 48695.8 48755.8 48805.3 48866.8 49963.0 49998.3 50025.2 50040.7 50057.0 14417.9 14521.5 14539.1 14543.9 14544.3 10258.5 10390.4 11923.0 11931.5 11951.1 11147.4 11247.8 11278.4 11297.0 12354.3 4676.4 5013.3 5158.7 5281.2 5282.6 965.6 1050.0 1053.6 1073.4 1077.6 22475.8 22993.7 23090.9 24351.8 24440.1 1101.7 1111.6 1132.0 1170.3 1173.7 12119.5 12465.8 16356.8 16377.1 16527.6 314622.0 316954.0 317110.0 318283.0 318439.0 54634.0 54659.0 54750.5 54793.5 55217.0 1499.6 1526.8 1546.5 1546.8 1555.3 28532.4 29004.1 29403.6 29423.4 29426.6 37986.1 38053.2 38067.6 38074.4 38099.2 280312.6 280324.0 280878.0 281000.0 281416.0 26200.2 32976.3 33577.8 34818.5 35003.8 37925.8 38261.0 38634.2 45213.5 45366.3 24894.3 28761.9 30855.7 31752.8 32152.0 30597.8 31126.8 31237.7 31325.0 31874.4 35505.1 36545.0 37271.3 37314.0 37811.8 30722.0 31404.7 31637.7 32087.7 32135.4 19764.1 21799.9 23602.2 24377.6 24437.8 17:43:31 INFO - PID 1648 | 17:43:31 INFO - PID 1648 | [#2] jquery.html Cycles:180 Average:39185.77 Median:22619.27 stddev:112270.02 (496.3%) stddev-sans-first:112547.26 17:43:31 INFO - PID 1648 | Values: 436.4 439.8 439.9 447.1 460.4 16051.8 21437.7 21986.0 22192.9 22254.7 21631.1 22628.7 23183.4 23517.6 23599.1 6024.5 6035.2 6228.6 6232.6 6255.8 5978.5 6211.3 6235.1 6244.1 6250.0 5845.6 5971.3 6192.7 6200.8 6205.3 6048.1 6181.8 6182.8 6183.0 6186.9 4788.2 5423.3 5470.9 5477.0 5490.4 27630.8 27645.9 27684.6 27750.3 28021.9 2199.9 2265.6 2265.7 2268.8 2271.2 17747.9 17889.6 18236.3 18238.1 18393.2 2134.4 2147.0 2208.9 2209.8 2216.7 144052.0 144546.3 145210.8 146162.3 159520.8 10589.0 11762.0 11795.0 12297.4 12427.3 16352.8 16374.5 16382.0 16382.9 16406.6 8226.8 8529.4 8925.1 9158.0 9255.6 8533.2 8864.8 8871.4 9068.5 9085.0 6825.9 7659.8 7803.4 7828.0 7851.3 1955.4 2029.2 2145.8 2162.4 2320.7 962.9 974.9 992.5 1023.7 1025.5 19964.2 20793.5 21080.9 21164.5 21419.9 989.2 993.7 1024.4 1031.9 1033.5 10568.0 10874.1 10953.4 10974.7 10978.6 664994.0 666613.0 667670.0 681511.0 682839.0 100914.0 118691.4 122159.4 125005.0 149219.0 1149.7 1206.3 1237.9 1241.6 1246.0 19603.2 21866.9 22126.8 22356.9 22609.9 62376.7 63400.0 63528.7 64119.4 64161.7 87087.6 87667.6 87903.6 88060.6 88771.0 8657.6 8780.6 8808.1 8977.9 9145.0 13454.2 13547.7 13571.3 13942.2 14057.7 12011.3 12121.6 12281.8 12397.3 12470.9 11401.1 11578.4 11633.8 11926.3 11956.8 10195.3 11786.6 11886.8 11983.0 12293.0 8840.6 9038.3 9075.0 9093.8 9103.8 10105.0 11737.5 11915.9 12158.6 12303.3 17:43:31 INFO - PID 1648 | 17:43:31 INFO - PID 1648 | [#3] mootools.html Cycles:180 Average:7169.08 Median:2569.33 stddev:4598.80 (179.0%) stddev-sans-first:4590.99 17:43:31 INFO - PID 1648 | Values: 1361.7 1411.9 1443.5 1444.6 1451.9 11555.9 12101.0 12114.5 12114.9 12153.0 11615.5 11806.6 12015.8 12053.6 12072.0 2524.1 2567.6 2571.1 2571.8 2577.6 2108.3 2494.9 2541.9 2542.3 2544.7 1987.4 2535.9 2538.3 2544.4 2546.9 2437.1 2438.8 2455.2 2462.4 2468.5 2109.9 2115.0 2513.1 2516.0 2521.8 9810.0 11798.8 11939.3 11943.5 11960.8 6342.7 6468.1 6481.3 6529.5 6813.3 4105.8 4241.3 4269.3 4332.2 4344.1 1213.1 1239.1 1270.5 1278.4 1295.1 15274.5 15735.3 15744.4 16767.4 17000.3 5207.4 5284.5 5532.7 5614.7 5834.9 12505.8 12531.9 12539.3 12560.4 12566.5 5807.7 6056.0 6420.2 6680.4 6714.3 6064.9 6246.0 6258.2 6269.7 6273.5 4387.6 4416.8 4476.0 4514.0 4519.5 1302.2 1304.5 1307.3 1325.4 1329.6 794.9 797.1 802.8 814.6 839.1 6063.4 6069.2 6293.8 6301.1 6418.8 587.2 596.8 600.3 603.9 610.3 3610.8 3781.6 3878.5 3890.6 3937.9 14532.3 15186.2 15337.8 15613.8 15615.0 15029.9 15283.5 15511.9 15548.7 15562.5 10998.1 11034.3 11074.7 11199.3 11349.1 5652.2 6966.6 7210.9 7225.1 7238.3 13172.7 13229.3 13272.5 13644.1 13667.7 11265.7 11476.4 14015.2 14221.9 14352.0 8623.8 8668.9 8704.7 8746.7 8809.1 10743.3 10856.4 10866.9 10869.6 10876.2 7808.3 9024.0 9275.7 9276.4 9344.1 9051.7 9091.7 9181.4 9182.2 9274.9 8047.5 8289.3 8343.7 8360.8 8373.7 6024.6 6025.2 6050.2 6092.9 6281.2 5438.5 5857.9 5871.4 6116.4 6203.1 17:43:31 INFO - PID 1648 | 17:43:31 INFO - PID 1648 | [#4] prototype.html Cycles:180 Average:5069.45 Median:5614.41 stddev:1505.89 (26.8%) stddev-sans-first:1468.72 17:43:31 INFO - PID 1648 | Values: 398.0 404.8 405.1 405.5 412.9 4842.7 5842.8 5910.2 5948.2 5975.1 4538.3 5667.9 5723.3 5837.6 5845.9 3635.7 4454.8 4471.9 4493.5 4518.8 3856.0 4380.9 4488.9 4509.6 4524.0 3867.5 4377.5 4436.3 4467.4 4477.0 4434.7 4438.8 4463.7 4464.1 4472.0 3959.1 3983.7 3989.8 4023.5 4030.0 5380.6 5672.3 5767.5 5798.2 5798.5 5353.5 5391.4 5393.5 5401.9 5432.9 6210.3 6227.3 6267.4 6301.3 6305.1 4339.6 4480.6 4505.7 4521.9 4601.4 6244.7 6417.6 6462.9 6468.9 6481.8 3893.0 4546.4 4618.6 4643.4 4645.7 4451.0 4538.8 4719.6 4738.3 4779.4 5158.2 5173.4 5305.8 5322.4 5340.8 6283.3 6289.2 6300.3 6301.3 6325.7 1531.7 1607.3 1607.7 1611.6 1626.9 1104.5 1116.5 1133.6 1136.9 1145.4 4758.9 4801.4 4896.4 5657.3 5732.8 5513.7 6294.7 6334.3 6408.0 6453.9 5526.5 5742.9 5750.7 5793.3 5893.8 2938.3 2955.4 3301.5 3350.8 3373.4 5925.8 6410.6 6514.9 6594.2 6672.2 5409.6 6482.2 6602.5 6623.4 6659.5 5415.8 6572.9 6580.1 6585.9 6610.0 5057.8 6020.8 6403.3 6433.4 6444.3 5424.9 6007.0 6077.3 6338.2 6343.5 5581.5 5647.3 5754.1 5762.0 6372.3 4106.8 4149.1 4186.4 4292.6 4320.8 5814.3 6169.8 6345.0 6462.2 6477.7 6184.0 6196.8 6220.7 6225.3 6244.3 5072.0 5988.9 6064.8 6151.2 6188.0 5998.6 6002.4 6026.5 6045.2 6076.5 5557.7 5787.3 6005.5 6074.6 6239.5 5491.9 5870.7 5943.5 6032.9 6081.1 17:43:31 INFO - PID 1648 | 17:43:31 INFO - PID 1648 | [#5] yui.html Cycles:180 Average:20936.07 Median:18134.46 stddev:28548.32 (157.4%) stddev-sans-first:28588.02 17:43:31 INFO - PID 1648 | Values: 713.0 798.0 864.5 871.6 882.9 13495.7 18164.5 18809.5 18863.2 18933.8 17614.0 17643.3 18019.7 18093.5 18104.5 980.1 1000.3 1002.4 1004.2 1004.5 671.9 689.4 693.3 1017.6 1025.1 741.4 743.6 893.2 1016.4 1060.6 1046.7 1047.9 1049.6 1050.7 1051.5 778.4 778.5 780.0 782.1 784.7 16495.3 16735.6 16874.8 17039.7 17432.3 16762.7 16946.8 17347.5 17366.1 17396.6 13784.9 13991.0 13991.9 13998.2 14100.8 3446.0 3457.3 3462.4 3468.0 3477.8 84331.0 104331.6 104765.0 105285.5 106330.0 11996.0 12121.4 12182.1 13033.3 13423.3 24916.8 25193.2 25387.0 25630.4 25776.6 8982.0 9034.2 9135.4 9232.2 9238.8 4824.2 4919.3 4921.1 4924.7 4929.0 4295.0 4333.2 4424.2 4425.5 4431.6 940.0 963.4 964.9 965.7 968.4 654.6 655.5 666.4 671.8 701.8 9334.3 9469.6 10743.8 11581.7 11871.2 649.5 667.3 669.5 680.5 691.8 5382.4 5487.9 5515.5 5544.3 5622.7 108701.0 109297.5 112411.4 114748.0 115023.4 88801.0 88906.0 89029.6 90061.2 90517.0 71779.0 73045.6 75462.6 76125.0 77265.6 12053.0 12289.8 12450.3 12564.4 12630.6 37940.6 38290.6 38535.4 38781.8 39471.0 51631.5 52442.7 52714.9 52834.7 52906.5 15537.2 15789.0 15856.0 15903.8 16023.4 17545.3 17586.4 17640.9 17783.7 17947.8 16108.3 16310.4 16334.4 16379.6 16483.7 15751.8 15864.6 16180.5 16213.4 16302.8 15384.8 15582.4 15659.9 15672.6 15901.0 11604.4 11797.5 11880.6 11969.9 12032.4 12270.7 12311.4 12326.5 12354.6 12529.2 17:43:31 INFO - PID 1648 | -------- Summary: end -------- 17:43:31 INFO - PID 1648 | 17:43:32 INFO - TEST-INFO | 1648: exit 0 17:43:32 INFO - TEST-OK | dromaeo_css | took 1119626ms 17:43:32 INFO - TEST-START | kraken 17:43:32 INFO - operating with platform_type : mac_ 17:43:32 INFO - Initialising browser for kraken test... 17:43:32 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpKPqYid/profile http://localhost:49241/getInfo.html) 17:43:35 INFO - PID 1659 | __metrics Screen width/height:1600/1200 17:43:35 INFO - PID 1659 | colorDepth:24 17:43:35 INFO - PID 1659 | Browser inner width/height: 1024/689 17:43:35 INFO - PID 1659 | __metrics 17:43:35 INFO - PID 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:43:35 INFO - PID 1659 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:43:36 INFO - TEST-INFO | 1659: exit 0 17:43:36 INFO - Browser initialized. 17:43:36 INFO - Running cycle 1/1 for kraken test... 17:43:36 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpKPqYid/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:48 INFO - PID 1660 | RSS: Main: 240189440 17:43:48 INFO - PID 1660 | 17:43:51 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 17:43:52 INFO - PID 1660 | RSS: Main: 292900864 17:43:52 INFO - PID 1660 | 17:43:55 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 17:43:56 INFO - PID 1660 | RSS: Main: 293900288 17:43:56 INFO - PID 1660 | 17:43:59 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 17:44:00 INFO - PID 1660 | RSS: Main: 387076096 17:44:00 INFO - PID 1660 | 17:44:02 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 17:44:03 INFO - PID 1660 | RSS: Main: 288178176 17:44:03 INFO - PID 1660 | 17:44:05 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:44:05 INFO - PID 1660 | RSS: Main: 292487168 17:44:05 INFO - PID 1660 | 17:44:08 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 17:44:09 INFO - PID 1660 | RSS: Main: 336089088 17:44:09 INFO - PID 1660 | 17:44:12 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 17:44:13 INFO - PID 1660 | RSS: Main: 339984384 17:44:13 INFO - PID 1660 | 17:44:16 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 17:44:17 INFO - PID 1660 | RSS: Main: 340398080 17:44:17 INFO - PID 1660 | 17:44:18 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:44:19 INFO - PID 1660 | RSS: Main: 311341056 17:44:19 INFO - PID 1660 | 17:44:21 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:44:21 INFO - PID 1660 | RSS: Main: 315170816 17:44:21 INFO - PID 1660 | 17:44:24 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:44:24 INFO - PID 1660 | RSS: Main: 316801024 17:44:24 INFO - PID 1660 | 17:44:27 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:44:28 INFO - PID 1660 | RSS: Main: 334651392 17:44:28 INFO - PID 1660 | 17:44:32 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:44:32 INFO - PID 1660 | RSS: Main: 318033920 17:44:32 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 17:44:34 INFO - PID 1660 | RSS: Main: 383713280 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | __start_tp_report 17:44:34 INFO - PID 1660 | _x_x_mozilla_page_load 17:44:34 INFO - PID 1660 | _x_x_mozilla_page_load_details 17:44:34 INFO - PID 1660 | |i|pagename|runs| 17:44:34 INFO - PID 1660 | |0;ai-astar;112;122;121;123;126;122;120;122;104;170 17:44:34 INFO - PID 1660 | |1;audio-beat-detection;151;121;118;162;120;122;156;118;143;119 17:44:34 INFO - PID 1660 | |2;audio-dft;211;216;214;213;216;211;222;218;211;216 17:44:34 INFO - PID 1660 | |3;audio-fft;86;68;65;98;68;64;64;64;80;72 17:44:34 INFO - PID 1660 | |4;audio-oscillator;98;78;94;78;77;76;94;73;75;93 17:44:34 INFO - PID 1660 | |5;imaging-gaussian-blur;92;94;91;93;92;91;93;92;92;91 17:44:34 INFO - PID 1660 | |6;imaging-darkroom;102;102;101;100;99;101;101;102;100;100 17:44:34 INFO - PID 1660 | |7;imaging-desaturate;100;121;108;160;102;101;99;101;100;97 17:44:34 INFO - PID 1660 | |8;json-parse-financial;53;52;51;52;53;52;55;54;52;56 17:44:34 INFO - PID 1660 | |9;json-stringify-tinderbox;70;64;70;68;67;63;64;65;65;66 17:44:34 INFO - PID 1660 | |10;stanford-crypto-aes;92;92;89;93;92;89;91;92;90;89 17:44:34 INFO - PID 1660 | |11;stanford-crypto-ccm;150;151;151;153;153;162;168;151;189;168 17:44:34 INFO - PID 1660 | |12;stanford-crypto-pbkdf2;203;198;202;208;235;244;215;236;205;202 17:44:34 INFO - PID 1660 | |13;stanford-crypto-sha256-iterative;74;73;75;74;72;75;74;72;73;72 17:44:34 INFO - PID 1660 | __end_tp_report 17:44:34 INFO - PID 1660 | __start_cc_report 17:44:34 INFO - PID 1660 | _x_x_mozilla_cycle_collect,2243 17:44:34 INFO - PID 1660 | __end_cc_report 17:44:34 INFO - PID 1660 | __startTimestamp1492044274967__endTimestamp 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | ------- Summary: start ------- 17:44:34 INFO - PID 1660 | Number of tests: 14 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#0] ai-astar Cycles:10 Average:124.20 Median:122.00 stddev:17.33 (14.2%) stddev-sans-first:17.81 17:44:34 INFO - PID 1660 | Values: 112.0 122.0 121.0 123.0 126.0 122.0 120.0 122.0 104.0 170.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:132.50 stddev:17.87 (13.5%) stddev-sans-first:17.73 17:44:34 INFO - PID 1660 | Values: 151.0 121.0 118.0 162.0 120.0 122.0 156.0 118.0 143.0 119.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#2] audio-dft Cycles:10 Average:214.80 Median:216.00 stddev:3.55 (1.6%) stddev-sans-first:3.49 17:44:34 INFO - PID 1660 | Values: 211.0 216.0 214.0 213.0 216.0 211.0 222.0 218.0 211.0 216.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#3] audio-fft Cycles:10 Average:72.90 Median:70.00 stddev:11.55 (16.5%) stddev-sans-first:11.24 17:44:34 INFO - PID 1660 | Values: 86.0 68.0 65.0 98.0 68.0 64.0 64.0 64.0 80.0 72.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#4] audio-oscillator Cycles:10 Average:83.60 Median:85.50 stddev:9.79 (11.4%) stddev-sans-first:8.89 17:44:34 INFO - PID 1660 | Values: 98.0 78.0 94.0 78.0 77.0 76.0 94.0 73.0 75.0 93.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:92.00 stddev:0.99 (1.1%) stddev-sans-first:1.05 17:44:34 INFO - PID 1660 | Values: 92.0 94.0 91.0 93.0 92.0 91.0 93.0 92.0 92.0 91.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#6] imaging-darkroom Cycles:10 Average:100.80 Median:101.50 stddev:1.03 (1.0%) stddev-sans-first:1.00 17:44:34 INFO - PID 1660 | Values: 102.0 102.0 101.0 100.0 99.0 101.0 101.0 102.0 100.0 100.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#7] imaging-desaturate Cycles:10 Average:108.90 Median:114.50 stddev:19.23 (16.8%) stddev-sans-first:20.13 17:44:34 INFO - PID 1660 | Values: 100.0 121.0 108.0 160.0 102.0 101.0 99.0 101.0 100.0 97.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:1.56 (2.9%) stddev-sans-first:1.66 17:44:34 INFO - PID 1660 | Values: 53.0 52.0 51.0 52.0 53.0 52.0 55.0 54.0 52.0 56.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.50 stddev:2.49 (3.7%) stddev-sans-first:2.22 17:44:34 INFO - PID 1660 | Values: 70.0 64.0 70.0 68.0 67.0 63.0 64.0 65.0 65.0 66.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:92.00 stddev:1.52 (1.7%) stddev-sans-first:1.56 17:44:34 INFO - PID 1660 | Values: 92.0 92.0 89.0 93.0 92.0 89.0 91.0 92.0 90.0 89.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:159.60 Median:157.50 stddev:12.53 (8.0%) stddev-sans-first:12.80 17:44:34 INFO - PID 1660 | Values: 150.0 151.0 151.0 153.0 153.0 162.0 168.0 151.0 189.0 168.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:214.80 Median:211.50 stddev:17.00 (8.0%) stddev-sans-first:17.49 17:44:34 INFO - PID 1660 | Values: 203.0 198.0 202.0 208.0 235.0 244.0 215.0 236.0 205.0 202.0 17:44:34 INFO - PID 1660 | 17:44:34 INFO - PID 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:74.00 stddev:1.17 (1.6%) stddev-sans-first:1.22 17:44:34 INFO - PID 1660 | Values: 74.0 73.0 75.0 74.0 72.0 75.0 74.0 72.0 73.0 72.0 17:44:34 INFO - PID 1660 | -------- Summary: end -------- 17:44:34 INFO - PID 1660 | 17:44:36 INFO - TEST-INFO | 1660: exit 0 17:44:36 INFO - TEST-OK | kraken | took 63619ms 17:44:36 INFO - SUITE-END | took 1183s 17:44:36 INFO - Completed test suite (00:19:43) 17:44:36 INFO - javascript benchmark 17:44:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7804.408930530303, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.786024978251, 3496.230829217571, 3498.7201023918083, 3537.6285490023547, 3559.804210768408, 6073.635581865091, 6115.60544095844, 6212.813615591534, 6232.594881332716, 6246.781362652308, 5209.791608335662, 6070.54470914682, 6145.494353883294, 6145.784897528587, 6243.063540468932, 5271.630985830974, 5353.5984801139975, 5354.544863686591, 5387.111126664116, 5529.281193444846, 5494.890102197954, 5500.367457742351, 5500.50495455409, 5500.889982200353, 5501.4223506531835, 5272.894542109175, 5382.91925621116, 5383.623146379755, 5390.460953904618, 5460.7542660580175, 5390.029794636964, 5404.216388623628, 5408.8377348679605, 5466.835994920159, 5483.985462689376, 5363.222332761728, 5369.785208591652, 5370.946290537123, 5378.811741589065, 5417.918731219035, 6049.48579370754, 6117.541184411187, 6142.539309551757, 6155.784547540815, 6167.321594624633, 5899.1446240295345, 6338.809835704937, 6397.616143031387, 6481.449076828475, 6571.44142747867, 6649.102371179877, 6651.334866513358, 6660.167479065117, 6661.666916654196, 6678.065070890079, 6136.294326152461, 6185.0, 6245.000799871998, 6246.375362463808, 6250.6874656267, 6505.316941721051, 6605.24039735427, 6643.933560664332, 6696.8995465068065, 6801.1838579369805, 6447.742090316428, 6454.225492940784, 6456.418922297016, 6459.709313080923, 6477.417032467007, 5541.944580554224, 6514.54398192122, 6636.203655561363, 6636.435902948207, 6660.23407308156, 6301.558890877686, 6352.237731472253, 6361.809145725636, 6477.093206951031, 6551.836204094936, 6480.708368123445, 6530.249021362604, 6535.901961470582, 6556.967215163893, 6567.211934567882, 5284.128118860345, 5303.708296043755, 5310.468953104736, 5315.335583052119, 5349.0, 4175.8956026099595, 4649.418822647169, 4683.1336202802595, 4699.083678682692, 4734.053189362141, 5898.8230353089475, 6146.4775494082605, 6188.8762224755255, 6231.750729970841, 6234.2830574484515, 6603.339666033358, 6604.1084453599115, 6607.240167380716, 6608.471322294301, 6639.734410623521, 6198.246286678856, 6238.157848690459, 6250.124982502453, 6251.3123556408755, 6259.874802503924, 5701.315842098892, 5757.280339957505, 5774.538036957033, 5777.653340799566, 5854.736536855852, 6775.525713200029, 6783.0, 6785.626790526569, 6788.9660551696925, 6793.5244532882225, 6390.808275751735, 6421.8715625688155, 6466.0, 6555.016747487724, 6659.467242620675, 6728.158980127484, 6746.4940129489505, 6750.25747167821, 6750.696218670073, 6758.662066896733, 6317.210348706411, 6510.283868774336, 6511.3163117871945, 6517.967410162919, 6523.151990241238, 6383.872322553616, 6468.126802881551, 6556.147700799056, 6605.834854128685, 6624.271330153583, 6368.172137622079, 6383.0744542042075, 6390.616563006234, 6396.520260980538, 6434.581752186093, 6406.0, 6416.390442907917, 6425.742970281136, 6434.967825160844, 6439.356064393523, 6228.34602366745, 6270.278917924497, 6273.99616061428, 6274.341194174728, 6310.463610593151, 6417.935820641734, 6440.227172739301, 6440.2915679276175, 6462.159919210472, 6466.708998095003, 6281.466075383643, 6316.147320111726, 6334.493240540838, 6336.809895703136, 6345.302016778059], "value": 6012.396707942067, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.4524993130324, 759.2217976574011, 814.682273913174, 1145.410113791397, 1158.6176561734628, 27692.58461123082, 36232.45651315229, 36917.446238306446, 37062.258754824885, 37121.886343409744, 38393.0, 38622.42066369006, 38778.0, 38789.418158727574, 38835.61164388355, 6112.572119951606, 7125.465590080738, 8678.132186781302, 8687.56562171892, 8705.477671339708, 6186.969065154668, 8310.875336869953, 8512.106228845974, 8532.914670853304, 8551.016633087213, 8545.0, 8560.229579337889, 8582.78543036426, 8584.957075214616, 8585.441946273504, 8503.107173746761, 8555.10171431997, 8569.442986205877, 8573.22840944318, 8603.053664096975, 8467.872981905277, 8504.192101750325, 8518.488890666518, 8519.701810436605, 8534.274586660142, 37215.627843721486, 37400.0, 37505.812470937744, 37523.24953500942, 37676.246475070344, 3573.5890372607223, 3610.7472476926628, 3618.203995121069, 3623.3296840084404, 3628.2924829658227, 30535.389292214255, 30646.62090205924, 30652.8467357664, 30666.0, 30683.0, 3134.059782065394, 3175.1268401189627, 3181.984090079558, 3190.058932614861, 3202.071399294225, 234389.0, 236892.0, 237712.0, 239331.0, 240037.0, 48535.0, 48695.756521217874, 48755.781105471935, 48805.26792098121, 48866.75566622144, 49963.0, 49998.25002624963, 50025.24962125571, 50040.74979625151, 50057.0, 14417.92791036038, 14521.491747788778, 14539.054961427684, 14543.854561454462, 14544.27278636064, 10258.538365773558, 10390.428526430967, 11923.046156307648, 11931.463084161234, 11951.103667224992, 11147.38689372076, 11247.83128253077, 11278.436078196057, 11297.0, 12354.320512371725, 4676.392069031072, 5013.323201367842, 5158.74206289684, 5281.15501519755, 5282.577393808486, 965.6137544982064, 1049.994750026245, 1053.599632139782, 1073.436445865911, 1077.5528155815248, 22475.775242247695, 22993.655095173584, 23090.884545577166, 24351.75648243495, 24440.06719193708, 1101.7245688577855, 1111.5887121765, 1132.0321125437797, 1170.2627344772739, 1173.6889724223088, 12119.515219391125, 12465.75068498625, 16356.754648680278, 16377.0992595406, 16527.559211967822, 314622.0, 316954.0, 317110.0, 318283.0, 318439.0, 54634.0, 54659.0, 54750.45249547533, 54793.452065478836, 55217.0, 1499.640086379283, 1526.8167819861465, 1546.4819285539245, 1546.7525195968592, 1555.3389809330988, 28532.42935141327, 29004.08444859917, 29403.55894661539, 29423.411531768816, 29426.558601620563, 37986.050348741504, 38053.23893522169, 38067.61932380641, 38074.42888356732, 38099.238015240095, 280312.5984370065, 280324.0, 280878.0, 281000.0, 281416.0, 26200.213993580222, 32976.34047318992, 33577.83211083929, 34818.47772283367, 35003.77486788052, 37925.81037094797, 38261.0, 38634.22731545297, 45213.54786452094, 45366.31950520679, 24894.270004412734, 28761.856190718914, 30855.69144308618, 31752.841235793672, 32152.0, 30597.847010764803, 31126.844365778026, 31237.687623124388, 31325.0, 31874.362512750078, 35505.1123721909, 36545.0, 37271.254574907805, 37314.0, 37811.81094094512, 30722.0, 31404.685953140175, 31637.683623163473, 32087.67912320847, 32135.357292854478, 19764.0825711, 21799.91000450003, 23602.17392391258, 24377.63433548463, 24437.75562244426], "value": 17338.713497742974, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.4260996789224, 439.82626862389355, 439.85484790019296, 447.14818271193377, 460.4083752378195, 16051.75922361164, 21437.67843482349, 21986.01062952167, 22192.8890355548, 22254.666180007313, 21631.134754609797, 22628.660570091422, 23183.420414489647, 23517.647235291442, 23599.05603775847, 6024.518038556916, 6035.215421995134, 6228.5951413158, 6232.563720539564, 6255.812325630239, 5978.461938425541, 6211.347808480113, 6235.127082208494, 6244.06339049144, 6250.000000000001, 5845.567835880215, 5971.343152253248, 6192.721327540249, 6200.78297259596, 6205.3484384139465, 6048.123022161784, 6181.845453863644, 6182.783602573933, 6183.010718285075, 6186.876262474771, 4788.162071637485, 5423.2949716537, 5470.91793623096, 5477.0, 5490.423505531941, 27630.75661595233, 27645.86177069102, 27684.584731229046, 27750.3062423439, 28021.859890700416, 2199.8900054997184, 2265.569541787055, 2265.728112626479, 2268.7958083772373, 2271.159670921753, 17747.911260443743, 17889.600975814552, 18236.270549178018, 18238.08809559517, 18393.172307246205, 2134.4343748906554, 2146.9570608587896, 2208.9447763806033, 2209.7900699433526, 2216.711827462436, 144052.0, 144546.27726861404, 145210.7662773951, 146162.26918865443, 159520.83354165213, 10589.046985771318, 11762.000229980376, 11795.0, 12297.44661490235, 12427.254364738144, 16352.75470867938, 16374.508764736838, 16382.0170789753, 16382.918085409498, 16406.589835254214, 8226.84824124623, 8529.402941794015, 8925.062868398725, 9158.0, 9255.583498742573, 8533.232009119085, 8864.822703545893, 8871.379003469696, 9068.54657267134, 9084.955230148618, 6825.897611535831, 7659.808504787425, 7803.375729941591, 7828.0, 7851.332636725828, 1955.4036019014052, 2029.1883246701143, 2145.781328007988, 2162.3729118555757, 2320.6519022146813, 962.9215278887691, 974.8732664753537, 992.4690290694443, 1023.698009087321, 1025.4923812712755, 19964.201431942558, 20793.480162995744, 21080.894595526923, 21164.47088822792, 21419.92900354976, 989.1641562879355, 993.7465946183677, 1024.3700124423426, 1031.9071283584512, 1033.4884232305058, 10568.048875601233, 10874.130069594414, 10953.397563133945, 10974.670759877217, 10978.560857565768, 664994.0, 666613.0, 667670.0, 681511.0, 682839.0, 100914.0, 118691.40654296674, 122159.3948574884, 125005.0, 149219.0, 1149.683836944847, 1206.312401930891, 1237.9381030948596, 1241.596481143632, 1245.9875401245872, 19603.197216682005, 21866.89066554657, 22126.783026933674, 22356.888215558818, 22609.886950565142, 62376.688116559126, 63400.0, 63528.682356587924, 64119.358806411336, 64161.67919160374, 87087.56456217679, 87667.56166219128, 87903.56048219718, 88060.5596972011, 88771.0, 8657.567121643766, 8780.560971951505, 8808.075152108937, 8977.865332020156, 9145.039770823967, 13454.192748435125, 13547.729045419233, 13571.321433928462, 13942.163470191821, 14057.718845622825, 12011.339376334385, 12121.636350909486, 12281.815772763237, 12397.256164630151, 12470.875291246972, 11401.144914131308, 11578.363190024293, 11633.767324653629, 11926.344051077274, 11956.820647690118, 10195.286329956833, 11786.58746943853, 11886.82169767437, 11983.0, 12293.0, 8840.557972101498, 9038.276937844825, 9074.954625226832, 9093.77265568366, 9103.817923641622, 10105.0, 11737.530498779954, 11915.940420297842, 12158.574449894211, 12303.261804291771], "value": 10616.514779487687, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.666391734025, 1411.9011669183155, 1443.4731323067076, 1444.617176448241, 1451.920144392058, 11555.942220288898, 12101.031917446606, 12114.515419383226, 12114.878851211486, 12153.0, 11615.47730352134, 11806.645800625973, 12015.759684806299, 12053.638390848266, 12072.0, 2524.0660955446465, 2567.6020216866414, 2571.061562529682, 2571.819972601919, 2577.6133579962966, 2108.2937216032647, 2494.87525623719, 2541.936451588716, 2542.288159315385, 2544.7200807911113, 1987.3839109875912, 2535.8985640574356, 2538.3146550431375, 2544.414784599543, 2546.9235922922344, 2437.122635851092, 2438.7683170098812, 2455.2143314139485, 2462.4336402627405, 2468.469279105001, 2109.947251318714, 2115.0, 2513.1204078572537, 2516.0, 2521.8360806547516, 9810.0, 11798.823017654742, 11939.34333611651, 11943.462544185533, 11960.820587691192, 6342.746290148389, 6468.1268028815975, 6481.28705842357, 6529.5429319947625, 6813.284605116441, 4105.815238314253, 4241.34259189826, 4269.295566231568, 4332.1985432695055, 4344.131173765228, 1213.1172032568893, 1239.095460313967, 1270.491803278696, 1278.3735969375032, 1295.1452041652465, 15274.465393711278, 15735.291911863993, 15744.370225190978, 16767.413140540022, 17000.3199872005, 5207.4011488678525, 5284.497972692588, 5532.6680399176175, 5614.747336369873, 5834.912476312858, 12505.812412813815, 12531.93734031324, 12539.310337931502, 12560.371981400893, 12566.497340106476, 5807.651540907559, 6055.969720151459, 6420.165378500765, 6680.365365290289, 6714.261431242559, 6064.939350606437, 6245.968770156211, 6258.155149054819, 6269.7178626961895, 6273.466755325757, 4387.5868272450025, 4416.779161041935, 4476.0, 4513.954860451419, 4519.525449827786, 1302.2316833068535, 1304.4651692806094, 1307.2613973105165, 1325.4035683942266, 1329.5707114851573, 794.8648729715846, 797.0674311056079, 802.8193656427258, 814.608987685914, 839.072824528899, 6063.363346848606, 6069.180660610849, 6293.811185664437, 6301.14934483848, 6418.807435776934, 587.2277954489832, 596.773226174051, 600.3276330509857, 603.9063945088518, 610.3073012131263, 3610.8375123119, 3781.6029316921877, 3878.534575850916, 3890.630390112935, 3937.8818635440985, 14532.346044428026, 15186.24068796578, 15337.769933451007, 15613.765793513106, 15615.0, 15029.924850375679, 15283.541493755205, 15511.92244038795, 15548.678362339328, 15562.455314063953, 10998.091232127112, 11034.289685098822, 11074.723131921766, 11199.272047317061, 11349.148813838996, 5652.152177173457, 6966.616836074065, 7210.855782884418, 7225.1329840419485, 7238.312360325761, 13172.736545269232, 13229.272390018641, 13272.469101235842, 13644.113132646346, 13667.726645466835, 11265.71835704114, 11476.4261786912, 14015.159090454605, 14221.857781422466, 14352.0, 8623.82752344937, 8668.913310867063, 8704.738857834274, 8746.737597872074, 8809.11908809114, 10743.301685390425, 10856.402897840695, 10866.945665271624, 10869.619563315246, 10876.184286178726, 7808.258215469521, 9024.0, 9275.67535136267, 9276.350655454324, 9344.112309330603, 9051.728448146303, 9091.681791137278, 9181.357304988587, 9182.17360437564, 9274.860877086714, 8047.51714897108, 8289.253967142986, 8343.666253349798, 8360.83278334442, 8373.748787536384, 6024.638521688713, 6025.216721826135, 6050.183225264709, 6092.903277410109, 6281.214848143982, 5438.537724293479, 5857.9121313179485, 5871.354151043467, 6116.418940200674, 6203.100550420254], "value": 5339.470299492353, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.9621935916088, 404.82794812204804, 405.0966345050539, 405.50325850832735, 412.86994596702056, 4842.733649649268, 5842.766289348427, 5910.202122713433, 5948.167256584071, 5975.103734439831, 4538.341940418637, 5667.886642267152, 5723.341815691187, 5837.591368604189, 5845.895477628061, 3635.690966267857, 4454.754988475633, 4471.888202794924, 4493.4832494263255, 4518.819247230107, 3855.9807200964096, 4380.890477738066, 4488.932666010012, 4509.571590698878, 4523.977380113111, 3867.5358956925206, 4377.467886239822, 4436.29019356903, 4467.352233926079, 4477.0, 4434.711743736663, 4438.755868427235, 4463.665919226525, 4464.129494748526, 4471.955280447187, 3959.1487830116375, 3983.721139520235, 3989.842945545788, 4023.499555386803, 4030.0, 5380.596455265871, 5672.290963629546, 5767.452092051249, 5798.246227990377, 5798.536117110621, 5353.544948679367, 5391.433899440581, 5393.487618676219, 5401.891962160774, 5432.891342173134, 6210.285817130997, 6227.283862355842, 6267.435930766253, 6301.275353334379, 6305.076951529782, 4339.566043395666, 4480.6191473724775, 4505.707129036602, 4521.892136426596, 4601.378813860119, 6244.687765611747, 6417.550771446001, 6462.935370646233, 6468.902966455507, 6481.805545833632, 3893.0, 4546.363309208682, 4618.607418369409, 4643.419572553431, 4645.744484053342, 4450.954025803933, 4538.773061346919, 4719.622430205575, 4738.336632871401, 4779.354787103766, 5158.174692049254, 5173.405058418255, 5305.761240744176, 5322.3879253885525, 5340.786368545292, 6283.277423096311, 6289.182406287154, 6300.30696623371, 6301.275353334334, 6325.715342809584, 1531.6783475470054, 1607.3008241415023, 1607.694538037769, 1611.6212690017837, 1626.9349226031063, 1104.5471356743858, 1116.4975760907462, 1133.5749094089717, 1136.9374684392437, 1145.381493993251, 4758.904821903542, 4801.399825021872, 4896.36347274852, 5657.321121465368, 5732.824770921951, 5513.724313784375, 6294.685265736694, 6334.334894835976, 6407.967960160169, 6453.870922581522, 5526.50261476469, 5742.913856292159, 5750.683712395775, 5793.290979161157, 5893.793717219963, 2938.2507460597412, 2955.4089182163652, 3301.4882693182594, 3350.8272104763137, 3373.3807772269447, 5925.792597259076, 6410.583312084699, 6514.902276465857, 6594.241662208811, 6672.165979252593, 5409.56723462122, 6482.189726284215, 6602.537822352485, 6623.370779775913, 6659.500537459709, 5415.783368665288, 6572.901406478811, 6580.078788969548, 6585.868282634417, 6610.041543976096, 5057.848264552069, 6020.849478763066, 6403.295637479967, 6433.420992110732, 6444.323346048597, 5424.915016996695, 6007.0, 6077.331493535619, 6338.176037115146, 6343.4608058313715, 5581.5255703265675, 5647.29408823897, 5754.108113242454, 5761.971190144022, 6372.267189273293, 4106.7946602670345, 4149.149424367937, 4186.434831297857, 4292.570742925683, 4320.848770293024, 5814.30228372598, 6169.784057557964, 6345.0, 6462.192225971754, 6477.708503117276, 6184.0, 6196.783112591038, 6220.657863817352, 6225.315215326401, 6244.281907580505, 5072.036313100647, 5988.910166347596, 6064.818055458167, 6151.200343955257, 6187.978983467858, 5998.640081595118, 6002.399760024137, 6026.548008899438, 6045.153678485103, 6076.453119219292, 5557.694326812064, 5787.305523337226, 6005.489533389711, 6074.574779765374, 6239.4696450800375, 5491.945080549303, 5870.708444142282, 5943.465088142088, 6032.90950635732, 6081.14186332423], "value": 4618.415715322513, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.0302788208033, 797.9601019949002, 864.4813112132721, 871.5729292646605, 882.9470231786094, 13495.662608434783, 18164.455066348015, 18809.529761755963, 18863.15115819788, 18933.81066189336, 17614.0, 17643.294268229256, 18019.729704054418, 18093.4571962841, 18104.456866294033, 980.127686359141, 1000.3397757480064, 1002.413588050991, 1004.231762701534, 1004.5379125602232, 671.942884854788, 689.4139981016147, 693.3309356471004, 1017.5777052523194, 1025.0927928783044, 741.388354607451, 743.5650144665377, 893.2452077994085, 1016.374929418406, 1060.6499855047816, 1046.7278507588082, 1047.8952104789498, 1049.5854137615675, 1050.7268110291302, 1051.526812934179, 778.3500776851336, 778.4861991085857, 780.028864064238, 782.1435528096782, 784.6508303804809, 16495.257713402807, 16735.581610459714, 16874.83125168745, 17039.744403833953, 17432.302707891668, 16762.74855877163, 16946.83053169465, 17347.479575612753, 17366.131693415406, 17396.56508587283, 13784.862151378458, 13990.950678699139, 13991.930040349733, 13998.230097344642, 14100.788488172686, 3445.9655403445895, 3457.2739724657854, 3462.3940810358085, 3467.9826600866836, 3477.7739446935866, 84331.0, 104331.56684331506, 104764.95235047628, 105285.47357263241, 106330.0, 11996.0, 12121.39393030345, 12182.147249692614, 13033.348332583333, 13423.261720605266, 24916.75083249144, 25193.244202673948, 25387.0, 25630.359241019123, 25776.613350799755, 8981.955090224637, 9034.23209027227, 9135.360524763202, 9232.21526170283, 9238.76903077415, 4824.204006338915, 4919.3358896549225, 4921.089598424303, 4924.729139897268, 4928.950710492921, 4294.9785251073545, 4333.198358303661, 4424.181526417623, 4425.468943726709, 4431.645468362523, 939.9859002114973, 963.3786207895868, 964.9324547281764, 965.6909788867495, 968.4383057826444, 654.6334052930374, 655.5476721062452, 666.3869240298936, 671.7615246587488, 701.8491024429773, 9334.299927505464, 9469.621215151317, 10743.83884241737, 11581.652550423501, 11871.169018168817, 649.490150232075, 667.2693400726197, 669.4644284572323, 680.4760334542375, 691.8097523181166, 5382.381026181961, 5487.945120548823, 5515.4760297771645, 5544.3346798383645, 5622.718864056863, 108701.0, 109297.45351273351, 112411.43794280976, 114748.0, 115023.42488287673, 88801.0, 88906.0, 89029.55485222532, 90061.19015597788, 90517.0, 71778.97547171752, 73045.6347718258, 75462.6226868873, 76125.0, 77265.6136719324, 12053.0, 12289.754204916031, 12450.25298482094, 12564.371781411075, 12630.565631404112, 37940.62059379371, 38290.61709382982, 38535.42196866993, 38781.80609096937, 39471.013224669616, 51631.48368516267, 52442.68893277546, 52714.945701084995, 52834.73582632062, 52906.47093529169, 15537.22313884324, 15789.002773662905, 15856.048637081813, 15903.840961590698, 16023.439179628656, 17545.298188072335, 17586.38447654326, 17640.91179544094, 17783.73324400161, 17947.833390830077, 16108.27512761905, 16310.429134980219, 16334.428295010093, 16379.59051023734, 16483.67032659364, 15751.842481575037, 15864.60338491547, 16180.514584562481, 16213.35146594123, 16302.755458668367, 15384.769228461806, 15582.376704931676, 15659.921700391425, 15672.608184795472, 15901.0, 11604.361760103275, 11797.469113889723, 11880.643580692593, 11969.940150299193, 12032.398380080786, 12270.693232668898, 12311.445984930879, 12326.50693972231, 12354.622880151122, 12529.18560293578], "value": 8278.855682324192, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 122.0, 121.0, 123.0, 126.0, 122.0, 120.0, 122.0, 104.0, 170.0], "value": 124.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 118.0, 162.0, 120.0, 122.0, 156.0, 118.0, 143.0, 119.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 216.0, 214.0, 213.0, 216.0, 211.0, 222.0, 218.0, 211.0, 216.0], "value": 214.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 68.0, 65.0, 98.0, 68.0, 64.0, 64.0, 64.0, 80.0, 72.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 78.0, 94.0, 78.0, 77.0, 76.0, 94.0, 73.0, 75.0, 93.0], "value": 83.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 91.0, 93.0, 92.0, 91.0, 93.0, 92.0, 92.0, 91.0], "value": 92.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 102.0, 101.0, 100.0, 99.0, 101.0, 101.0, 102.0, 100.0, 100.0], "value": 100.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 121.0, 108.0, 160.0, 102.0, 101.0, 99.0, 101.0, 100.0, 97.0], "value": 108.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 52.0, 53.0, 52.0, 55.0, 54.0, 52.0, 56.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 64.0, 70.0, 68.0, 67.0, 63.0, 64.0, 65.0, 65.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 89.0, 93.0, 92.0, 89.0, 91.0, 92.0, 90.0, 89.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 153.0, 153.0, 162.0, 168.0, 151.0, 189.0, 168.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 198.0, 202.0, 208.0, 235.0, 244.0, 215.0, 236.0, 205.0, 202.0], "value": 214.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 74.0, 72.0, 75.0, 74.0, 72.0, 73.0, 72.0], "value": 73.4, "unit": "score"}]}]} 17:44:36 INFO - Return code: 0 17:44:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:44:36 ERROR - # TBPL SUCCESS # 17:44:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:44:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:44:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:44:36 INFO - 2017-04-12 17:44:36.292 screenresolution[1664:9956] starting screenresolution argv=screenresolution get 17:44:36 INFO - 2017-04-12 17:44:36.295 screenresolution[1664:9956] Display 0: 1600x1200x32@60 17:44:36 INFO - 2017-04-12 17:44:36.302 screenresolution[1665:9959] starting screenresolution argv=screenresolution list 17:44:36 INFO - Available Modes on Display 0 17:44:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:44:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:44:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:44:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:44:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:44:36 INFO - Intel Iris: 17:44:36 INFO - Chipset Model: Intel Iris 17:44:36 INFO - Type: GPU 17:44:36 INFO - Bus: Built-In 17:44:36 INFO - VRAM (Dynamic, Max): 1536 MB 17:44:36 INFO - Vendor: Intel (0x8086) 17:44:36 INFO - Device ID: 0x0a2e 17:44:36 INFO - Revision ID: 0x0009 17:44:36 INFO - Displays: 17:44:36 INFO - Display: 17:44:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:44:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:44:36 INFO - Display Serial Number: 1600x1200 60 17:44:36 INFO - Main Display: Yes 17:44:36 INFO - Mirror: Off 17:44:36 INFO - Online: Yes 17:44:36 INFO - Rotation: Supported 17:44:36 INFO - Return code: 0 17:44:36 INFO - Running post-action listener: _resource_record_post_action 17:44:36 INFO - [mozharness: 2017-04-13 00:44:36.547906Z] Finished run-tests step (success) 17:44:36 INFO - Running post-run listener: _resource_record_post_run 17:44:36 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 39478272; Write bytes: 514538496; Read time: 387; Write time: 2030 17:44:36 INFO - TinderboxPrint: CPU usage
53.3% 17:44:36 INFO - TinderboxPrint: I/O read bytes / time
39,478,272 / 387 17:44:36 INFO - TinderboxPrint: I/O write bytes / time
514,538,496 / 2,030 17:44:36 INFO - TinderboxPrint: CPU idle
2,246.1 (46.7%) 17:44:36 INFO - TinderboxPrint: CPU system
956.9 (19.9%) 17:44:36 INFO - TinderboxPrint: CPU user
1,610.6 (33.5%) 17:44:36 INFO - TinderboxPrint: Swap in / out
246,435,840 / 0 17:44:36 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194390528; Write bytes: 193677312; Read time: 14891; Write time: 506 17:44:36 INFO - run-tests - Wall time: 1184s; CPU: 53.0%; Read bytes: 38503424; Write bytes: 304014336; Read time: 370; Write time: 1454 17:44:37 INFO - Running post-run listener: _upload_blobber_files 17:44:37 INFO - Blob upload gear active. 17:44:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:44:37 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 17:44:37 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:44:37 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:44:37 INFO - (blobuploader) - INFO - Open directory for files ... 17:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:44:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:39 INFO - (blobuploader) - INFO - Done attempting. 17:44:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:44:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:44:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:40 INFO - (blobuploader) - INFO - Done attempting. 17:44:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:44:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:44:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:41 INFO - (blobuploader) - INFO - Done attempting. 17:44:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:44:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:44:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:43 INFO - (blobuploader) - INFO - Done attempting. 17:44:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:44:43 INFO - Return code: 0 17:44:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:44:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:44:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/1fc8e836e40e0af7e9f3aa6d604b28d90dcc39adfa02ac4faf72fbe11095e393dff49d8f8c94c545f0c61d2494c8ce4d19dcd2a970b25480515b0477971c87eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/34bd8843cea7cb6930940ed55509131ee0dddd49bab0b526170d631ef70d05cc2c714344d1e0496402745982bf5fecb5b87de5314b7f2d80a58da50fabbb4dda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/054c4d87e3d02d418fe673bbc2d58ba0a80f3ebb0133233123e4363d7facb51fb7f67c9d5ff975ffa57af3ffaabd33d3d2ff8d1182bfd64a8fff2946a1c253b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/70c536ddec37ef4d189d83bf5efcd7e1cc14c438a385558724f2c4cd8a7f32fe7b0234038d1748a1215dbc9615ef09ec027e9d910b97ff8562034c29169ee1dd"} 17:44:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:44:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:44:43 INFO - Contents: 17:44:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/1fc8e836e40e0af7e9f3aa6d604b28d90dcc39adfa02ac4faf72fbe11095e393dff49d8f8c94c545f0c61d2494c8ce4d19dcd2a970b25480515b0477971c87eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/34bd8843cea7cb6930940ed55509131ee0dddd49bab0b526170d631ef70d05cc2c714344d1e0496402745982bf5fecb5b87de5314b7f2d80a58da50fabbb4dda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/054c4d87e3d02d418fe673bbc2d58ba0a80f3ebb0133233123e4363d7facb51fb7f67c9d5ff975ffa57af3ffaabd33d3d2ff8d1182bfd64a8fff2946a1c253b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/70c536ddec37ef4d189d83bf5efcd7e1cc14c438a385558724f2c4cd8a7f32fe7b0234038d1748a1215dbc9615ef09ec027e9d910b97ff8562034c29169ee1dd"} 17:44:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:44:43 INFO - Copying logs to upload dir... 17:44:43 INFO - mkdir: /builds/slave/test/build/upload/logs 17:44:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.362499 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-12 17:44:43.241313) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 17:44:43.245135) ========= 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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/1fc8e836e40e0af7e9f3aa6d604b28d90dcc39adfa02ac4faf72fbe11095e393dff49d8f8c94c545f0c61d2494c8ce4d19dcd2a970b25480515b0477971c87eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/34bd8843cea7cb6930940ed55509131ee0dddd49bab0b526170d631ef70d05cc2c714344d1e0496402745982bf5fecb5b87de5314b7f2d80a58da50fabbb4dda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/054c4d87e3d02d418fe673bbc2d58ba0a80f3ebb0133233123e4363d7facb51fb7f67c9d5ff975ffa57af3ffaabd33d3d2ff8d1182bfd64a8fff2946a1c253b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/70c536ddec37ef4d189d83bf5efcd7e1cc14c438a385558724f2c4cd8a7f32fe7b0234038d1748a1215dbc9615ef09ec027e9d910b97ff8562034c29169ee1dd"} build_url:https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.012135 build_url: 'https://queue.taskcluster.net/v1/task/UBENQhR2SsmnEw96TJndJQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/1fc8e836e40e0af7e9f3aa6d604b28d90dcc39adfa02ac4faf72fbe11095e393dff49d8f8c94c545f0c61d2494c8ce4d19dcd2a970b25480515b0477971c87eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/34bd8843cea7cb6930940ed55509131ee0dddd49bab0b526170d631ef70d05cc2c714344d1e0496402745982bf5fecb5b87de5314b7f2d80a58da50fabbb4dda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/054c4d87e3d02d418fe673bbc2d58ba0a80f3ebb0133233123e4363d7facb51fb7f67c9d5ff975ffa57af3ffaabd33d3d2ff8d1182bfd64a8fff2946a1c253b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/70c536ddec37ef4d189d83bf5efcd7e1cc14c438a385558724f2c4cd8a7f32fe7b0234038d1748a1215dbc9615ef09ec027e9d910b97ff8562034c29169ee1dd"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 17:44:43.285228) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 17:44:43.285560) ========= 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.Q0gZpsfuDE/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.Fu6iIdRa7O/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005609 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 17:44:43.334627) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 17:44:43.334959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 17:44:43.335277) ========= ========= Total master_lag: 0.18 =========