builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0062 starttime: 1475635356.78 results: success (0) buildid: 20161004174501 builduid: 390c0f768f53402bbee0bfb378a985f0 revision: ea104eeb14cc54da9a06c3766da63f73117723a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 19:42:36.784081) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 19:42:36.784612) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 19:42:36.784934) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 19:42:37.021460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 19:42:37.021813) ========= 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.mYoHpRRnkg/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.rCcPgrQadf/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-04 19:42:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.38M=0.001s 2016-10-04 19:42:37 (8.38 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.198629 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 19:42:37.272130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 19:42:37.272419) ========= 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.mYoHpRRnkg/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.rCcPgrQadf/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.020707 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 19:42:37.332908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 19:42:37.333229) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea104eeb14cc54da9a06c3766da63f73117723a0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ea104eeb14cc54da9a06c3766da63f73117723a0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mYoHpRRnkg/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.rCcPgrQadf/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-04 19:42:37,406 truncating revision to first 12 chars 2016-10-04 19:42:37,406 Setting DEBUG logging. 2016-10-04 19:42:37,406 attempt 1/10 2016-10-04 19:42:37,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea104eeb14cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 19:42:38,335 unpacking tar archive at: fx-team-ea104eeb14cc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.174985 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 19:42:38.535802) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 19:42:38.536077) ========= script_repo_revision: ea104eeb14cc54da9a06c3766da63f73117723a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 19:42:38.536445) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 19:42:38.536700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 19:42:38.560155) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-04 19:42:38.560543) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mYoHpRRnkg/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.rCcPgrQadf/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 19:42:38 INFO - MultiFileLogger online at 20161004 19:42:38 in /builds/slave/test 19:42:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:42:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:42:38 INFO - {'append_to_log': False, 19:42:38 INFO - 'base_work_dir': '/builds/slave/test', 19:42:38 INFO - 'blob_upload_branch': 'Fx-Team', 19:42:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:42:38 INFO - 'branch': 'Fx-Team', 19:42:38 INFO - 'buildbot_json_path': 'buildprops.json', 19:42:38 INFO - 'config_files': ('talos/mac_config.py',), 19:42:38 INFO - 'default_actions': ('clobber', 19:42:38 INFO - 'read-buildbot-config', 19:42:38 INFO - 'download-and-extract', 19:42:38 INFO - 'populate-webroot', 19:42:38 INFO - 'create-virtualenv', 19:42:38 INFO - 'install', 19:42:38 INFO - 'run-tests'), 19:42:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:42:38 INFO - 'download_minidump_stackwalk': True, 19:42:38 INFO - 'download_symbols': 'ondemand', 19:42:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:42:38 INFO - 'tooltool.py': '/tools/tooltool.py', 19:42:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:42:38 INFO - '/tools/misc-python/virtualenv.py')}, 19:42:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:42:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:42:38 INFO - 'installer_path': 'installer.exe', 19:42:38 INFO - 'log_level': 'info', 19:42:38 INFO - 'log_name': 'talos', 19:42:38 INFO - 'log_to_console': True, 19:42:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:42:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:42:38 INFO - 'opt_config_files': (), 19:42:38 INFO - 'pip_index': False, 19:42:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:42:38 INFO - 'cmd': ('bash', 19:42:38 INFO - '-c', 19:42:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:42:38 INFO - 'enabled': True, 19:42:38 INFO - 'halt_on_failure': False, 19:42:38 INFO - 'name': 'check_screen_resolution'},), 19:42:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:42:38 INFO - 'cmd': ('bash', 19:42:38 INFO - '-c', 19:42:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:42:38 INFO - 'enabled': True, 19:42:38 INFO - 'halt_on_failure': False, 19:42:38 INFO - 'name': 'check_screen_resolution'},), 19:42:38 INFO - 'run_cmd_checks_enabled': True, 19:42:38 INFO - 'sps_profile': False, 19:42:38 INFO - 'sps_profile_interval': 0, 19:42:38 INFO - 'suite': 'dromaeojs', 19:42:38 INFO - 'system_bits': '32', 19:42:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:42:38 INFO - 'title': 't-yosemite-r7-0062', 19:42:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:42:38 INFO - 'use_talos_json': True, 19:42:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:42:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:42:38 INFO - 'work_dir': 'build'} 19:42:38 INFO - [mozharness: 2016-10-05 02:42:38.755929Z] Running clobber step. 19:42:38 INFO - Running pre-action listener: _resource_record_pre_action 19:42:38 INFO - Running main action method: clobber 19:42:38 INFO - rmtree: /builds/slave/test/build 19:42:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:42:39 INFO - Running post-action listener: _resource_record_post_action 19:42:39 INFO - [mozharness: 2016-10-05 02:42:39.656066Z] Finished clobber step (success) 19:42:39 INFO - [mozharness: 2016-10-05 02:42:39.656226Z] Running read-buildbot-config step. 19:42:39 INFO - Running pre-action listener: _resource_record_pre_action 19:42:39 INFO - Running main action method: read_buildbot_config 19:42:39 INFO - Using buildbot properties: 19:42:39 INFO - { 19:42:39 INFO - "project": "", 19:42:39 INFO - "product": "firefox", 19:42:39 INFO - "script_repo_revision": "production", 19:42:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 19:42:39 INFO - "repository": "", 19:42:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 19:42:39 INFO - "buildid": "20161004174501", 19:42:39 INFO - "pgo_build": "False", 19:42:39 INFO - "basedir": "/builds/slave/test", 19:42:39 INFO - "buildnumber": 852, 19:42:39 INFO - "slavename": "t-yosemite-r7-0062", 19:42:39 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:42:39 INFO - "platform": "yosemite_r7", 19:42:39 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:42:39 INFO - "branch": "fx-team", 19:42:39 INFO - "repo_path": "integration/fx-team", 19:42:39 INFO - "revision": "ea104eeb14cc54da9a06c3766da63f73117723a0", 19:42:39 INFO - "stage_platform": "macosx64", 19:42:39 INFO - "builduid": "390c0f768f53402bbee0bfb378a985f0", 19:42:39 INFO - "slavebuilddir": "test" 19:42:39 INFO - } 19:42:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 19:42:39 INFO - Running post-action listener: _resource_record_post_action 19:42:39 INFO - [mozharness: 2016-10-05 02:42:39.659420Z] Finished read-buildbot-config step (success) 19:42:39 INFO - [mozharness: 2016-10-05 02:42:39.659511Z] Running download-and-extract step. 19:42:39 INFO - Running pre-action listener: _resource_record_pre_action 19:42:39 INFO - Running main action method: download_and_extract 19:42:39 INFO - mkdir: /builds/slave/test/build/tests 19:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:42:39 INFO - trying https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 19:42:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 19:42:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 19:42:40 INFO - Downloaded 1199 bytes. 19:42:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 19:42:40 INFO - Using the following test package requirements: 19:42:40 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 19:42:40 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:42:40 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 19:42:40 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:42:40 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 19:42:40 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:42:40 INFO - u'jsshell-mac.zip'], 19:42:40 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:42:40 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 19:42:40 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 19:42:40 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:42:40 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 19:42:40 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:42:40 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 19:42:40 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:42:40 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 19:42:40 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:42:40 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 19:42:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:42:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 19:42:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:42:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 19:42:41 INFO - Http code: 200 19:42:41 INFO - via: 1.1 88972e3933cc06dd11a6fa704a208631.cloudfront.net (CloudFront) 19:42:41 INFO - x-amz-cf-id: Lc6XDBN-mmvm29pLByusY78F_t_utiIHO0zC3olXyo_d5_tyf6J0nQ== 19:42:41 INFO - x-amz-version-id: hv7dmv7gR.MlDDR3lakCeQxBYlHPzYqS 19:42:41 INFO - Expected file size: 16476890 19:42:41 INFO - Obtained file size: 16476890 19:42:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:42:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 19:42:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:42:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 19:42:48 INFO - Http code: 200 19:42:48 INFO - via: 1.1 978198446b6fdba8a499c04f84a3a7e6.cloudfront.net (CloudFront) 19:42:48 INFO - x-amz-cf-id: z2u5Cp56-WWlpnZhKQI4mPryaAUyt8P6cWzq2iL-_k60o0R-WPRCag== 19:42:48 INFO - x-amz-version-id: hv7dmv7gR.MlDDR3lakCeQxBYlHPzYqS 19:42:49 INFO - Expected file size: 16476890 19:42:49 INFO - Obtained file size: 16476890 19:42:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 19:42:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:42:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 19:42:56 INFO - Http code: 200 19:42:56 INFO - via: 1.1 81871f1c889cc44b6c25e3ef722a3801.cloudfront.net (CloudFront) 19:42:56 INFO - x-amz-cf-id: oC0REAGoRWQLBPkfTNb7lq2wimOMWknT3LuQRn34EujqIxMeKsgK1A== 19:42:56 INFO - x-amz-version-id: SIkCNULxoGpwtAahh9prtCPjKoo7agSv 19:42:57 INFO - Expected file size: 14409006 19:42:57 INFO - Obtained file size: 14409006 19:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:42:57 INFO - trying https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:42:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 19:42:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 19:43:00 INFO - Downloaded 111719294 bytes. 19:43:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:43:00 INFO - mkdir: /builds/slave/test/properties 19:43:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:43:00 INFO - Writing to file /builds/slave/test/properties/build_url 19:43:00 INFO - Contents: 19:43:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:43:00 INFO - Running post-action listener: _resource_record_post_action 19:43:00 INFO - Running post-action listener: set_extra_try_arguments 19:43:00 INFO - [mozharness: 2016-10-05 02:43:00.916134Z] Finished download-and-extract step (success) 19:43:00 INFO - [mozharness: 2016-10-05 02:43:00.916240Z] Running populate-webroot step. 19:43:00 INFO - Running pre-action listener: _resource_record_pre_action 19:43:00 INFO - Running main action method: populate_webroot 19:43:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:43:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:43:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:43:00 INFO - '--tppagecycles', 19:43:00 INFO - '7'], 19:43:00 INFO - 'tests': ['tsvgm']}}, 19:43:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:43:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:43:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:43:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:43:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:43:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:43:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:00 INFO - 'talos_options': ['--disable-e10s'], 19:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:43:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:43:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:00 INFO - 'talos_options': ['--disable-e10s'], 19:43:00 INFO - 'tests': ['damp', 'tps']}, 19:43:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:00 INFO - 'tests': ['damp', 'tps']}, 19:43:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:43:00 INFO - 'tests': ['dromaeo_dom']}, 19:43:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:43:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:43:00 INFO - 'tests': ['basic_compositor_video']}, 19:43:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:43:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:43:00 INFO - 'tests': ['a11yr', 19:43:00 INFO - 'ts_paint', 19:43:00 INFO - 'tpaint', 19:43:00 INFO - 'sessionrestore', 19:43:00 INFO - 'sessionrestore_no_auto_restore', 19:43:00 INFO - 'tabpaint']}, 19:43:00 INFO - 'other-e10s': {'tests': ['a11yr', 19:43:00 INFO - 'ts_paint', 19:43:00 INFO - 'tpaint', 19:43:00 INFO - 'sessionrestore', 19:43:00 INFO - 'sessionrestore_no_auto_restore', 19:43:00 INFO - 'tabpaint']}, 19:43:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:43:00 INFO - 'ts_paint', 19:43:00 INFO - 'tpaint', 19:43:00 INFO - 'sessionrestore', 19:43:00 INFO - 'sessionrestore_no_auto_restore', 19:43:00 INFO - 'tabpaint']}, 19:43:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:43:00 INFO - 'ts_paint', 19:43:00 INFO - 'tpaint', 19:43:00 INFO - 'sessionrestore', 19:43:00 INFO - 'sessionrestore_no_auto_restore', 19:43:00 INFO - 'tabpaint']}, 19:43:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:43:00 INFO - 'tests': ['a11yr', 19:43:00 INFO - 'ts_paint', 19:43:00 INFO - 'tpaint', 19:43:00 INFO - 'sessionrestore', 19:43:00 INFO - 'sessionrestore_no_auto_restore', 19:43:00 INFO - 'tabpaint']}, 19:43:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:43:00 INFO - 'tests': ['a11yr', 19:43:00 INFO - 'ts_paint', 19:43:00 INFO - 'tpaint', 19:43:00 INFO - 'sessionrestore', 19:43:00 INFO - 'sessionrestore_no_auto_restore', 19:43:00 INFO - 'tabpaint']}, 19:43:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:43:00 INFO - 'tests': ['tsvgx', 19:43:00 INFO - 'tsvgr_opacity', 19:43:00 INFO - 'tart', 19:43:00 INFO - 'tscrollx', 19:43:00 INFO - 'cart']}, 19:43:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:43:00 INFO - 'tsvgr_opacity', 19:43:00 INFO - 'tart', 19:43:00 INFO - 'tscrollx', 19:43:00 INFO - 'cart']}, 19:43:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:00 INFO - 'talos_options': ['--disable-e10s'], 19:43:00 INFO - 'tests': ['tp5o']}, 19:43:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:00 INFO - 'tests': ['tp5o']}, 19:43:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:00 INFO - 'talos_options': ['--disable-e10s', 19:43:00 INFO - '--xperf_path', 19:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:43:00 INFO - 'tests': ['tp5n']}, 19:43:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:43:00 INFO - 'talos_options': ['--xperf_path', 19:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:43:00 INFO - 'tests': ['tp5n']}}, 19:43:00 INFO - 'talos.zip': {'path': '', 19:43:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:43:00 INFO - Running post-action listener: _resource_record_post_action 19:43:00 INFO - [mozharness: 2016-10-05 02:43:00.934364Z] Finished populate-webroot step (success) 19:43:00 INFO - [mozharness: 2016-10-05 02:43:00.934502Z] Running create-virtualenv step. 19:43:00 INFO - Running pre-action listener: _resource_record_pre_action 19:43:00 INFO - Running main action method: create_virtualenv 19:43:00 INFO - Creating virtualenv /builds/slave/test/build/venv 19:43:00 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 19:43:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:43:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:43:01 INFO - Using real prefix '/tools/python27' 19:43:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:43:01 INFO - Installing distribute.............................................................................................................................................................................................done. 19:43:04 INFO - Installing pip.................done. 19:43:04 INFO - Return code: 0 19:43:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:43:04 INFO - Reading from file tmpfile_stdout 19:43:04 INFO - Output received: 19:43:04 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) 19:43:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107768490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff43855b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10757cd30>, '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 0x1073a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107574b20>, '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.mYoHpRRnkg/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.rCcPgrQadf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 19:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:43:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mYoHpRRnkg/Render', 19:43:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:43:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:43:04 INFO - 'HOME': '/Users/cltbld', 19:43:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:43:04 INFO - 'LOGNAME': 'cltbld', 19:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:04 INFO - 'MOZ_NO_REMOTE': '1', 19:43:04 INFO - 'NO_EM_RESTART': '1', 19:43:04 INFO - 'PAGER': '/bin/cat', 19:43:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:04 INFO - 'PWD': '/builds/slave/test', 19:43:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:43:04 INFO - 'SHELL': '/bin/bash', 19:43:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rCcPgrQadf/Listeners', 19:43:04 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 19:43:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:43:04 INFO - 'USER': 'cltbld', 19:43:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:43:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:04 INFO - 'XPC_FLAGS': '0x0', 19:43:04 INFO - 'XPC_SERVICE_NAME': '0', 19:43:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:05 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 19:43:05 INFO - Cleaning up... 19:43:05 INFO - Return code: 0 19:43:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:43:05 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')]} 19:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:05 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')]} 19:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:05 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 0x107768490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff43855b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10757cd30>, '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 0x1073a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107574b20>, '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.mYoHpRRnkg/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.rCcPgrQadf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 19:43:05 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 19:43:05 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 19:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mYoHpRRnkg/Render', 19:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:43:05 INFO - 'HOME': '/Users/cltbld', 19:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:43:05 INFO - 'LOGNAME': 'cltbld', 19:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:05 INFO - 'MOZ_NO_REMOTE': '1', 19:43:05 INFO - 'NO_EM_RESTART': '1', 19:43:05 INFO - 'PAGER': '/bin/cat', 19:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:05 INFO - 'PWD': '/builds/slave/test', 19:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:43:05 INFO - 'SHELL': '/bin/bash', 19:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rCcPgrQadf/Listeners', 19:43:05 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 19:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:43:05 INFO - 'USER': 'cltbld', 19:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:05 INFO - 'XPC_FLAGS': '0x0', 19:43:05 INFO - 'XPC_SERVICE_NAME': '0', 19:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:05 INFO - Downloading/unpacking psutil>=3.1.1 19:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:43:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:09 INFO - Installing collected packages: psutil 19:43:09 INFO - Running setup.py install for psutil 19:43:09 INFO - building 'psutil._psutil_osx' extension 19:43:09 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 19:43:09 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 19:43:09 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 19:43:09 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 19:43:09 INFO - building 'psutil._psutil_posix' extension 19:43:09 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 19:43:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:43:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:43:09 INFO - ^ 19:43:09 INFO - 1 warning generated. 19:43:09 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 19:43:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:43:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:43:10 INFO - Successfully installed psutil 19:43:10 INFO - Cleaning up... 19:43:10 INFO - Return code: 0 19:43:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:10 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 0x107768490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff43855b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10757cd30>, '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 0x1073a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107574b20>, '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.mYoHpRRnkg/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.rCcPgrQadf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 19:43:10 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 19:43:10 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 19:43:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mYoHpRRnkg/Render', 19:43:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:43:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:43:10 INFO - 'HOME': '/Users/cltbld', 19:43:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:43:10 INFO - 'LOGNAME': 'cltbld', 19:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:10 INFO - 'MOZ_NO_REMOTE': '1', 19:43:10 INFO - 'NO_EM_RESTART': '1', 19:43:10 INFO - 'PAGER': '/bin/cat', 19:43:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:10 INFO - 'PWD': '/builds/slave/test', 19:43:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:43:10 INFO - 'SHELL': '/bin/bash', 19:43:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rCcPgrQadf/Listeners', 19:43:10 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 19:43:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:43:10 INFO - 'USER': 'cltbld', 19:43:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:43:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:10 INFO - 'XPC_FLAGS': '0x0', 19:43:10 INFO - 'XPC_SERVICE_NAME': '0', 19:43:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:43:10 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 19:43:10 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 19:43:10 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 19:43:10 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 19:43:10 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 19:43:10 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 19:43:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:43:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:43:12 INFO - Installing collected packages: mozsystemmonitor 19:43:12 INFO - Running setup.py install for mozsystemmonitor 19:43:13 INFO - Successfully installed mozsystemmonitor 19:43:13 INFO - Cleaning up... 19:43:13 INFO - Return code: 0 19:43:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:43:13 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')]} 19:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:13 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')]} 19:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:13 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 0x107768490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff43855b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10757cd30>, '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 0x1073a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107574b20>, '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.mYoHpRRnkg/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.rCcPgrQadf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 19:43:13 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 19:43:13 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 19:43:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mYoHpRRnkg/Render', 19:43:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:43:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:43:13 INFO - 'HOME': '/Users/cltbld', 19:43:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:43:13 INFO - 'LOGNAME': 'cltbld', 19:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:13 INFO - 'MOZ_NO_REMOTE': '1', 19:43:13 INFO - 'NO_EM_RESTART': '1', 19:43:13 INFO - 'PAGER': '/bin/cat', 19:43:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:13 INFO - 'PWD': '/builds/slave/test', 19:43:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:43:13 INFO - 'SHELL': '/bin/bash', 19:43:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rCcPgrQadf/Listeners', 19:43:13 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 19:43:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:43:13 INFO - 'USER': 'cltbld', 19:43:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:43:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:13 INFO - 'XPC_FLAGS': '0x0', 19:43:13 INFO - 'XPC_SERVICE_NAME': '0', 19:43:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:13 INFO - Downloading/unpacking jsonschema==2.5.1 19:43:13 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 19:43:13 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 19:43:13 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 19:43:13 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 19:43:13 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 19:43:13 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 19:43:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:43:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:43: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 19:43: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 19:43: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 19:43: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 19:43: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 19:43: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 19:43:16 INFO - Downloading functools32-3.2.3-2.tar.gz 19:43:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:43:16 INFO - warning: no files found matching '*.txt' 19:43:16 INFO - no previously-included directories found matching 'build' 19:43:16 INFO - no previously-included directories found matching 'dist' 19:43:16 INFO - no previously-included directories found matching '.git*' 19:43:16 INFO - Installing collected packages: jsonschema, functools32 19:43:16 INFO - Running setup.py install for functools32 19:43:16 INFO - warning: no files found matching '*.txt' 19:43:16 INFO - no previously-included directories found matching 'build' 19:43:16 INFO - no previously-included directories found matching 'dist' 19:43:16 INFO - no previously-included directories found matching '.git*' 19:43:16 INFO - Successfully installed jsonschema functools32 19:43:16 INFO - Cleaning up... 19:43:16 INFO - Return code: 0 19:43:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:43: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')]} 19:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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')]} 19:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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 0x107768490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff43855b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10757cd30>, '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 0x1073a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107574b20>, '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.mYoHpRRnkg/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.rCcPgrQadf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 19:43: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 19:43: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 19:43:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mYoHpRRnkg/Render', 19:43:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:43:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:43:16 INFO - 'HOME': '/Users/cltbld', 19:43:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:43:16 INFO - 'LOGNAME': 'cltbld', 19:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:16 INFO - 'MOZ_NO_REMOTE': '1', 19:43:16 INFO - 'NO_EM_RESTART': '1', 19:43:16 INFO - 'PAGER': '/bin/cat', 19:43:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:16 INFO - 'PWD': '/builds/slave/test', 19:43:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:43:16 INFO - 'SHELL': '/bin/bash', 19:43:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rCcPgrQadf/Listeners', 19:43:16 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 19:43:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:43:16 INFO - 'USER': 'cltbld', 19:43:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:43:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:16 INFO - 'XPC_FLAGS': '0x0', 19:43:16 INFO - 'XPC_SERVICE_NAME': '0', 19:43:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:43:16 INFO - Cleaning up... 19:43:17 INFO - Return code: 0 19:43:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:43: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')]} 19:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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')]} 19:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43:17 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 0x107768490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff43855b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10757cd30>, '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 0x1073a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107574b20>, '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.mYoHpRRnkg/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.rCcPgrQadf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 19:43:17 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 19:43:17 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 19:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mYoHpRRnkg/Render', 19:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:43:17 INFO - 'HOME': '/Users/cltbld', 19:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:43:17 INFO - 'LOGNAME': 'cltbld', 19:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:17 INFO - 'MOZ_NO_REMOTE': '1', 19:43:17 INFO - 'NO_EM_RESTART': '1', 19:43:17 INFO - 'PAGER': '/bin/cat', 19:43:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:17 INFO - 'PWD': '/builds/slave/test', 19:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:43:17 INFO - 'SHELL': '/bin/bash', 19:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rCcPgrQadf/Listeners', 19:43:17 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 19:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:43:17 INFO - 'USER': 'cltbld', 19:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:17 INFO - 'XPC_FLAGS': '0x0', 19:43:17 INFO - 'XPC_SERVICE_NAME': '0', 19:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:17 INFO - Downloading/unpacking blobuploader==1.2.4 19:43:17 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 19:43:17 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 19:43:17 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 19:43:17 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 19:43:17 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 19:43:17 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 19:43:19 INFO - Downloading blobuploader-1.2.4.tar.gz 19:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:43:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:43: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 19:43: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 19:43: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 19:43: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 19:43: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 19:43: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 19:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:43:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:43: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 19:43: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 19:43: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 19:43: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 19:43: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 19:43: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 19:43:20 INFO - Downloading docopt-0.6.1.tar.gz 19:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:43:21 INFO - Installing collected packages: blobuploader, requests, docopt 19:43:21 INFO - Running setup.py install for blobuploader 19:43:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:43:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:43:21 INFO - Running setup.py install for requests 19:43:21 INFO - Running setup.py install for docopt 19:43:21 INFO - Successfully installed blobuploader requests docopt 19:43:21 INFO - Cleaning up... 19:43:21 INFO - Return code: 0 19:43:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43: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')]} 19:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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')]} 19:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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 0x107768490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff43855b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10757cd30>, '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 0x1073a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107574b20>, '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.mYoHpRRnkg/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.rCcPgrQadf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 19:43: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 19:43: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 19:43:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mYoHpRRnkg/Render', 19:43:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:43:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:43:21 INFO - 'HOME': '/Users/cltbld', 19:43:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:43:21 INFO - 'LOGNAME': 'cltbld', 19:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:21 INFO - 'MOZ_NO_REMOTE': '1', 19:43:21 INFO - 'NO_EM_RESTART': '1', 19:43:21 INFO - 'PAGER': '/bin/cat', 19:43:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:21 INFO - 'PWD': '/builds/slave/test', 19:43:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:43:21 INFO - 'SHELL': '/bin/bash', 19:43:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rCcPgrQadf/Listeners', 19:43:21 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 19:43:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:43:21 INFO - 'USER': 'cltbld', 19:43:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:43:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:21 INFO - 'XPC_FLAGS': '0x0', 19:43:21 INFO - 'XPC_SERVICE_NAME': '0', 19:43:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:43:22 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-8eQjA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:43:22 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-NHAI5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:43:22 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-DRN8_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:43:22 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-OGkqfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:43:22 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-rLrk_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:43:22 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-_JDbeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:43:22 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-NWJSER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:43:22 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-A5inon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:43:22 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-xZ445f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:43:23 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ogd3WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:43:23 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-lk7XMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:43:23 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-QY2xbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:43:23 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-pG6wy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:43:23 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-pqQOtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:23 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-wNAfBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:43:23 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-0omxIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:43:23 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-DKzFtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:43:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:43:23 INFO - Running setup.py install for manifestparser 19:43:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:43:24 INFO - Running setup.py install for mozcrash 19:43:24 INFO - Running setup.py install for mozdebug 19:43:24 INFO - Running setup.py install for mozdevice 19:43:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:43:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:43:24 INFO - Running setup.py install for mozfile 19:43:24 INFO - Running setup.py install for mozhttpd 19:43:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:43:24 INFO - Running setup.py install for mozinfo 19:43:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:43:24 INFO - Running setup.py install for mozInstall 19:43:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:43:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:43:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:43:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:43:25 INFO - Running setup.py install for mozleak 19:43:25 INFO - Running setup.py install for mozlog 19:43:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:43:25 INFO - Running setup.py install for moznetwork 19:43:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:43:25 INFO - Running setup.py install for mozprocess 19:43:25 INFO - Running setup.py install for mozprofile 19:43:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:43:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:43:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:43:25 INFO - Running setup.py install for mozrunner 19:43:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:43:26 INFO - Running setup.py install for mozscreenshot 19:43:26 INFO - Running setup.py install for moztest 19:43:26 INFO - Running setup.py install for mozversion 19:43:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:43:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:43:26 INFO - Cleaning up... 19:43:26 INFO - Return code: 0 19:43:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43: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')]} 19:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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')]} 19:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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 0x107768490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff43855b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10757cd30>, '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 0x1073a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107574b20>, '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.mYoHpRRnkg/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.rCcPgrQadf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 19:43: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 19:43: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 19:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mYoHpRRnkg/Render', 19:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:43:26 INFO - 'HOME': '/Users/cltbld', 19:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:43:26 INFO - 'LOGNAME': 'cltbld', 19:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:26 INFO - 'MOZ_NO_REMOTE': '1', 19:43:26 INFO - 'NO_EM_RESTART': '1', 19:43:26 INFO - 'PAGER': '/bin/cat', 19:43:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:26 INFO - 'PWD': '/builds/slave/test', 19:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:43:26 INFO - 'SHELL': '/bin/bash', 19:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rCcPgrQadf/Listeners', 19:43:26 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 19:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:43:26 INFO - 'USER': 'cltbld', 19:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:26 INFO - 'XPC_FLAGS': '0x0', 19:43:26 INFO - 'XPC_SERVICE_NAME': '0', 19:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:43:26 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-mAW1SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:43: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)) 19:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:43:26 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ioJETm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:43:26 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-crDtX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:43: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)) 19:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:43:27 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-y8PiCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:43:27 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-iz4Ehf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:43: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)) 19:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:43:27 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-fJ1Hb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:43: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)) 19:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:43:27 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ZFzLoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:43: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)) 19:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:43:27 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-qr4ZPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:43: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)) 19:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:43:27 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-RavejQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:43: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)) 19:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:43:27 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-8cquWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:43: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)) 19:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:43:27 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-d12Q4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:43: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)) 19:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:43:27 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-EyBQlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:43:28 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-7usToN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:43: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)) 19:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:43:28 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-qJxl9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:43:28 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-7syhi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:43: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)) 19:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:43:28 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Ty8kuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:43:28 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-BJ87BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:43: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)) 19:43: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:43: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:43: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)) 19:43: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:43: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:43:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:43: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 19:43: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 19:43: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 19:43: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 19:43: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 19:43: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 19:43:30 INFO - Downloading blessings-1.6.tar.gz 19:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:43:31 INFO - Installing collected packages: blessings 19:43:31 INFO - Running setup.py install for blessings 19:43:31 INFO - Successfully installed blessings 19:43:31 INFO - Cleaning up... 19:43:31 INFO - Return code: 0 19:43:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:43:31 INFO - Reading from file tmpfile_stdout 19:43:31 INFO - Current package versions: 19:43:31 INFO - blessings == 1.6 19:43:31 INFO - blobuploader == 1.2.4 19:43:31 INFO - docopt == 0.6.1 19:43:31 INFO - functools32 == 3.2.3-2 19:43:31 INFO - jsonschema == 2.5.1 19:43:31 INFO - manifestparser == 1.1 19:43:31 INFO - mozInstall == 1.12 19:43:31 INFO - mozcrash == 0.17 19:43:31 INFO - mozdebug == 0.1 19:43:31 INFO - mozdevice == 0.48 19:43:31 INFO - mozfile == 1.2 19:43:31 INFO - mozhttpd == 0.7 19:43:31 INFO - mozinfo == 0.9 19:43:31 INFO - mozleak == 0.1 19:43:31 INFO - mozlog == 3.4 19:43:31 INFO - moznetwork == 0.27 19:43:31 INFO - mozprocess == 0.23 19:43:31 INFO - mozprofile == 0.28 19:43:31 INFO - mozrunner == 6.12 19:43:31 INFO - mozscreenshot == 0.1 19:43:31 INFO - mozsystemmonitor == 0.3 19:43:31 INFO - moztest == 0.7 19:43:31 INFO - mozversion == 1.4 19:43:31 INFO - psutil == 3.1.1 19:43:31 INFO - requests == 1.2.3 19:43:31 INFO - wsgiref == 0.1.2 19:43:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:43: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')]} 19:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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')]} 19:43:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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 0x107768490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff43855b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10757cd30>, '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 0x1073a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107574b20>, '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.mYoHpRRnkg/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.rCcPgrQadf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 19:43: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 19:43: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 19:43:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mYoHpRRnkg/Render', 19:43:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:43:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:43:31 INFO - 'HOME': '/Users/cltbld', 19:43:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:43:31 INFO - 'LOGNAME': 'cltbld', 19:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:31 INFO - 'MOZ_NO_REMOTE': '1', 19:43:31 INFO - 'NO_EM_RESTART': '1', 19:43:31 INFO - 'PAGER': '/bin/cat', 19:43:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:31 INFO - 'PWD': '/builds/slave/test', 19:43:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:43:31 INFO - 'SHELL': '/bin/bash', 19:43:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rCcPgrQadf/Listeners', 19:43:31 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 19:43:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:43:31 INFO - 'USER': 'cltbld', 19:43:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:43:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:31 INFO - 'XPC_FLAGS': '0x0', 19:43:31 INFO - 'XPC_SERVICE_NAME': '0', 19:43:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43: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)) 19:43: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)) 19:43: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)) 19:43: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)) 19:43: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)) 19:43: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)) 19:43: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)) 19:43: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)) 19:43: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)) 19:43: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)) 19:43: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)) 19:43:31 INFO - Cleaning up... 19:43:31 INFO - Return code: 0 19:43:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:43: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')]} 19:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:43:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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')]} 19:43:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:43:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:43: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 0x107768490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff43855b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10757cd30>, '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 0x1073a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107574b20>, '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.mYoHpRRnkg/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.rCcPgrQadf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 19:43: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 19:43: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 19:43:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mYoHpRRnkg/Render', 19:43:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:43:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:43:31 INFO - 'HOME': '/Users/cltbld', 19:43:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:43:31 INFO - 'LOGNAME': 'cltbld', 19:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:31 INFO - 'MOZ_NO_REMOTE': '1', 19:43:31 INFO - 'NO_EM_RESTART': '1', 19:43:31 INFO - 'PAGER': '/bin/cat', 19:43:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:31 INFO - 'PWD': '/builds/slave/test', 19:43:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:43:31 INFO - 'SHELL': '/bin/bash', 19:43:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rCcPgrQadf/Listeners', 19:43:31 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 19:43:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:43:31 INFO - 'USER': 'cltbld', 19:43:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:43:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:31 INFO - 'XPC_FLAGS': '0x0', 19:43:31 INFO - 'XPC_SERVICE_NAME': '0', 19:43:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:43:32 INFO - Cleaning up... 19:43:32 INFO - Return code: 0 19:43:32 INFO - Running post-action listener: _resource_record_post_action 19:43:32 INFO - Running post-action listener: _start_resource_monitoring 19:43:32 INFO - Starting resource monitoring. 19:43:32 INFO - [mozharness: 2016-10-05 02:43:32.195221Z] Finished create-virtualenv step (success) 19:43:32 INFO - [mozharness: 2016-10-05 02:43:32.196213Z] Running install step. 19:43:32 INFO - Running pre-action listener: _resource_record_pre_action 19:43:32 INFO - Running main action method: install 19:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:43:32 INFO - Reading from file tmpfile_stdout 19:43:32 INFO - Detecting whether we're running mozinstall >=1.0... 19:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:43:32 INFO - Reading from file tmpfile_stdout 19:43:32 INFO - Output received: 19:43:32 INFO - Usage: mozinstall [options] installer 19:43:32 INFO - Options: 19:43:32 INFO - -h, --help show this help message and exit 19:43:32 INFO - -d DEST, --destination=DEST 19:43:32 INFO - Directory to install application into. [default: 19:43:32 INFO - "/builds/slave/test"] 19:43:32 INFO - --app=APP Application being installed. [default: firefox] 19:43:32 INFO - mkdir: /builds/slave/test/build/application 19:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:44:06 INFO - Reading from file tmpfile_stdout 19:44:06 INFO - Output received: 19:44:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:44:06 INFO - Running post-action listener: _resource_record_post_action 19:44:06 INFO - [mozharness: 2016-10-05 02:44:06.530173Z] Finished install step (success) 19:44:06 INFO - [mozharness: 2016-10-05 02:44:06.530308Z] Running run-tests step. 19:44:06 INFO - Running pre-action listener: _resource_record_pre_action 19:44:06 INFO - Running main action method: run_tests 19:44:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:44:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:44:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:44:06 INFO - 2016-10-04 19:44:06.544 screenresolution[1935:14596] starting screenresolution argv=screenresolution get 19:44:06 INFO - 2016-10-04 19:44:06.547 screenresolution[1935:14596] Display 0: 1600x1200x32@60 19:44:06 INFO - 2016-10-04 19:44:06.552 screenresolution[1936:14598] starting screenresolution argv=screenresolution list 19:44:06 INFO - Available Modes on Display 0 19:44:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:44:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:44:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:44:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:44:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:44:06 INFO - Intel Iris: 19:44:06 INFO - Chipset Model: Intel Iris 19:44:06 INFO - Type: GPU 19:44:06 INFO - Bus: Built-In 19:44:06 INFO - VRAM (Dynamic, Max): 1536 MB 19:44:06 INFO - Vendor: Intel (0x8086) 19:44:06 INFO - Device ID: 0x0a2e 19:44:06 INFO - Revision ID: 0x0009 19:44:06 INFO - Displays: 19:44:06 INFO - Display: 19:44:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:44:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:44:06 INFO - Display Serial Number: 1600x1200 60 19:44:06 INFO - Main Display: Yes 19:44:06 INFO - Mirror: Off 19:44:06 INFO - Online: Yes 19:44:06 INFO - Rotation: Supported 19:44:06 INFO - Return code: 0 19:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:44:06 INFO - Python 2.7.3 19:44:06 INFO - Return code: 0 19:44:06 INFO - grabbing minidump binary from tooltool 19:44:06 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')]} 19:44:06 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 0x10757cd30>, '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 0x1073a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107574b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:44:06 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 19:44:06 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 19:44:06 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 19:44:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:44:06 INFO - Return code: 0 19:44:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:44:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:44:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:44:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:44:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--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 19:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0062 --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 19:44:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mYoHpRRnkg/Render', 19:44:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:44:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:44:06 INFO - 'HOME': '/Users/cltbld', 19:44:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:44:06 INFO - 'LOGNAME': 'cltbld', 19:44:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:44:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:06 INFO - 'MOZ_NO_REMOTE': '1', 19:44:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:44:06 INFO - 'NO_EM_RESTART': '1', 19:44:06 INFO - 'PAGER': '/bin/cat', 19:44:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:06 INFO - 'PWD': '/builds/slave/test', 19:44:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:44:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:44:06 INFO - 'SHELL': '/bin/bash', 19:44:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rCcPgrQadf/Listeners', 19:44:06 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 19:44:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:44:06 INFO - 'USER': 'cltbld', 19:44:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:44:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:06 INFO - 'XPC_FLAGS': '0x0', 19:44:06 INFO - 'XPC_SERVICE_NAME': '0', 19:44:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:44:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--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 19:44:07 INFO - mozversion application_buildid: 20161004174501 19:44:07 INFO - mozversion application_changeset: ea104eeb14cc54da9a06c3766da63f73117723a0 19:44:07 INFO - mozversion application_display_name: Nightly 19:44:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:44:07 INFO - mozversion application_name: Firefox 19:44:07 INFO - mozversion application_remotingname: firefox 19:44:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:44:07 INFO - mozversion application_vendor: Mozilla 19:44:07 INFO - mozversion application_version: 52.0a1 19:44:07 INFO - mozversion platform_buildid: 20161004174501 19:44:07 INFO - mozversion platform_changeset: ea104eeb14cc54da9a06c3766da63f73117723a0 19:44:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:44:07 INFO - mozversion platform_version: 52.0a1 19:44:07 INFO - using testdate: 1475635447 19:44:07 INFO - actual date: 1475635447 19:44:07 INFO - starting webserver on 'localhost:49444' 19:44:07 INFO - SUITE-START | Running 2 tests 19:44:07 INFO - TEST-START | dromaeo_css 19:44:07 INFO - operating with platform_type : mac_ 19:44:07 INFO - Initialising browser for dromaeo_css test... 19:44:07 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpLth7u9/profile http://localhost:49444/getInfo.html) 19:44:09 INFO - PROCESS | 1946 | __metrics Screen width/height:1600/1200 19:44:09 INFO - PROCESS | 1946 | colorDepth:24 19:44:09 INFO - PROCESS | 1946 | Browser inner width/height: 1024/689 19:44:09 INFO - PROCESS | 1946 | __metrics 19:44:09 INFO - PROCESS | 1946 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:44:09 INFO - PROCESS | 1946 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:44:10 INFO - TEST-INFO | 1946: exit 0 19:44:10 INFO - Browser initialized. 19:44:10 INFO - Running cycle 1/1 for dromaeo_css test... 19:44:10 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpLth7u9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:44:22 INFO - PROCESS | 1948 | RSS: Main: 235876352 19:44:22 INFO - PROCESS | 1948 | 19:45:13 INFO - PROCESS | 1948 | 1475635513595 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:47:26 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49444/tests/dromaeo/cssquery-ext.html) 19:47:28 INFO - PROCESS | 1948 | RSS: Main: 367157248 19:47:28 INFO - PROCESS | 1948 | 19:50:31 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-ext.html (next: http://localhost:49444/tests/dromaeo/cssquery-jquery.html) 19:50:31 INFO - PROCESS | 1948 | RSS: Main: 372555776 19:50:31 INFO - PROCESS | 1948 | 19:53:34 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49444/tests/dromaeo/cssquery-mootools.html) 19:53:34 INFO - PROCESS | 1948 | RSS: Main: 348082176 19:53:34 INFO - PROCESS | 1948 | 19:56:37 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49444/tests/dromaeo/cssquery-prototype.html) 19:56:37 INFO - PROCESS | 1948 | RSS: Main: 340299776 19:56:37 INFO - PROCESS | 1948 | 19:59:41 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49444/tests/dromaeo/cssquery-yui.html) 19:59:41 INFO - PROCESS | 1948 | RSS: Main: 334204928 19:59:41 INFO - PROCESS | 1948 | 20:02:44 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:49444/tests/dromaeo/cssquery-yui.html (next: http://localhost:49444/tests/dromaeo/cssquery-dojo.html) 20:02:45 INFO - PROCESS | 1948 | RSS: Main: 437596160 20:02:45 INFO - PROCESS | 1948 | 20:02:45 INFO - PROCESS | 1948 | __start_tp_report 20:02:45 INFO - PROCESS | 1948 | _x_x_mozilla_page_load 20:02:45 INFO - PROCESS | 1948 | _x_x_mozilla_page_load_details 20:02:45 INFO - PROCESS | 1948 | |i|pagename|runs| 20:02:45 INFO - PROCESS | 1948 | |0;dojo.html;2756.4487102579483;3264.151320656629;3315.1214928044055;3335.3329334133177;3336.099253201637;5606.663600183992;5609.635373700712;5672.290963629546;5702.4012478689765;5714.057180565207;5679.261695979527;5703.3441154267275;5778.4799368056865;5789.39211382804;5804.622699524539;4999.325091112708;5131.409887862887;5157.4068982067165;5193.091209038422;5194.246834209038;5162.638615296931;5294.682319060849;5299.655522391052;5318.6011049171275;5326.760295786679;5255.789768409298;5265.631405801595;5288.5504732097625;5342.385625653042;5358.946410535884;5083.694978301313;5119.641625086246;5153.56194723449;5165.560927321182;5207.4792520748;5081.28861959326;5129.0767661820855;5149.794008239666;5193.948060519384;5198.5841132709675;5651.18057881609;5697.77208911643;5699.116636921284;5742.799002034951;5757.050086735683;6075.453209211148;6107.886786452505;6134.263888333428;6136.539759518054;6151.507879369639;6114.409200427198;6134.294556126058;6138.549551575117;6160.815175544741;6172;5798.130280457881;5802.419758024248;5803.941960580382;5813.447722466359;5839.416058394169;6065.848353791102;6167.506599472032;6211.720472578654;6250.312465628777;6251.374862513803;5639.407862174495;5653.349864765604;6113.266408031065;6134.78528251509;6157.4458298753325;6162;6166.630002199882;6181.567290289637;6183.072539119168;6192.442680158807;6110.877782444326;6116.633002019893;6168.845778855564;6185.257769067741;6192.81421557354;6095.529019716752;6103.115048317969;6128.594790794077;6129.20597562684;6165.876682466325;4888.120138375056;4927.1131196384995;4941.50584941503;4966.925496117561;4970.627202959792;4392.494863090786;4411.20598292304;4414.763866117492;4421.624161946206;4460.241758900995;5562.9443705563235;5665.3201615806365;5690.5447564194765;5696.6582005079;5753.252077229933;6149.292831324455;6159.922013647593;6195.752169913153;6208.844778880474;6216.937830621727;5707.971460142673;5715.942840571624;5719.399463056319;5719.428057194331;5751.1373294006235;5356.491133342326;5359.946400536022;5360.437154098841;5363.168708850135;5381.4349493303425;6147.678249176449;6149.0776383542825;6150.985087460698;6196.566240363131;6208.441240288395;6155.261368635793;6243.656598886923;6246.344133865879;6256.186695729526;6272.40412160844;6229.159063526366;6240.219972503437;6257.4994000480765;6258.780942666985;6260.68696565179;6062.878742425215;6097.207363042776;6103.908441373472;6116.724747386467;6176.629402235881;6138.541671868701;6203.193584833943;6227.595206311576;6230.7819226328675;6232.376762323732;6046.516278697605;6089.69551522431;6113.510919126548;6118;6124.050772130327;5949.851253718692;6004.309504406874;6066.666333351532;6094.1773158968435;6117.035835319669;5828.562857785768;5910.320313164041;5990.460858522754;6003.8198854034445;6083.756649733961;6057.212562366864;6092.908606370819;6093.542984276109;6106.7862624809695;6108.75564977396;5796.362400136066;5817.505512031525;5823.79616713413;5854.297484301911;5881.470667639933 20:02:45 INFO - PROCESS | 1948 | |1;ext.html;459.91261660284545;496.89316796888664;530.9044372013038;532.3266068423443;535.9785608575655;30424.239394015134;39736.20527589446;41147.971300717494;41221.38167927483;41261.381079283834;39870.60129398705;41328.79335603325;41630.791846040804;41734.79132604333;41758.58241417585;8701.434406763572;9692.612295508188;9839.16367108793;9860.161886239679;9863.95068024659;8794.076621954699;11898.405079746022;12187.939060304687;12213.45039473226;12283.631491055283;12139.271643701362;12206.145569810116;12212.32832194229;12234;12235.632931012084;8848.778780530474;9066.637334506611;12117.878821211807;12175.0868684849;12222.816657750096;7613.467057305936;7627.61861906908;7700.152983171903;11739.530418783239;12133.575324863676;40067.79966100151;40508.189836203404;40508.39237411441;40540;40544.98637534056;3279.212988882675;3336.049225970611;3401.6088149862835;3554.697850682695;3590.676839084495;30022.84988575065;30400.84799575988;31215.843920780477;31298;31331.37337253242;3293.143782616537;3328.267781088181;3340.9665903341142;3392.168918614955;3402.2344972381266;369507;373314;374295.1285243584;375156;375361.123194385;55578.72210638921;55886.72056639772;55979.60050998758;55987;56036.719816400655;59133.113003304985;59144;59165.112523312186;59226.70386648039;59264.40735592589;13197.934010329887;15294.847051529565;15679.843201567839;15695.921520392325;15698.136602486744;10944.124470042378;11220.326780393203;12227.510899564095;12342.629721108382;12434.316112613713;14741.189234591986;15105.54683359501;15115.168665723271;15122.09267443957;15128;5447.836564903059;6260.906086408708;6608.900866487006;7044.506884518035;7044.859102818017;894.4141587260355;952.1620973543238;970.1365784451843;1022.0545994954638;1036.233187441303;23903;27253.318667033484;27343;30107.69892301049;30263;1037.9636712715019;1039.417925961464;1071.5124618298655;1075.854759607443;1215.392303848076;12752;15366.31089559345;15478.458253961056;15509.720930463996;15684.137372444397;630345;633408;635947;637817;639368;55300.72349638226;55408.44591554113;55535;55670.443295566525;55812;1355.3697530648296;1358.5041459867275;1368.2337890780996;1368.3842270978298;1373.642852858264;26252.81862316162;28309;28447.715522844508;29012.709872901;30121.945731900156;47990;48543;48580.5141948576;48592.5140748588;48644.513554863996;582811;583029;585198;589225.2154956963;589772;38201.61798381981;38662.613373865905;39467.01332466711;39579;39646.80176599098;45869.54130458653;46552.7672361636;46813.76593117013;47256.52743472521;47415.762921185174;37130;38160.618393815705;38194.427083594324;39329.803350983064;39781.80109099436;37844;38185.6181438182;38268;39150.80424597859;39564.40653390259;31394.744210231336;37088;38132.856014319615;38297.61702382941;38322.80838595789;30509.93215237456;31188.844055779577;33831.4925276126;34196;34260.82869585636;22550.651266156583;25146.11988580391;25187.74812251854;25715;25975 20:02:45 INFO - PROCESS | 1948 | |2;jquery.html;353.5933676272288;364.48425477948706;372.6310952157365;380.516743735456;401.73485499570273;12373.443195056221;13122.737545249101;16218.351265949363;20538.383848484533;20997.58004839906;17068.82931170688;18366.724499132524;19911.40265792025;20353.38939831804;21326.253581124663;5868.559858010655;6095.695215239242;6122.63264204147;6192.287886892997;6193.566450348478;5030.9183525542;6198.4731297839735;6217.937820621781;6228.439440450358;6250.374962503759;6189.195404597396;6191.969040154815;6208.78269260576;6210.8447288817915;7610.200928902468;7777.300042996101;7837.921620783804;7954.920450795505;8076.71731489395;8081.474704144271;7796.61016949156;7882.566458844762;7884.290413862723;7888.40836937232;7896.289333959971;25193;27136.592951105747;27561.586576201375;28393.858030709715;28749;2358.846674966139;2422.5760491913843;2527.7093134289607;3041.6045914031256;3245.675432456759;15472.92263538675;15670.686586268212;17317.653646927116;17564.560885977826;17573.7363939541;1958.9608207835906;1970.173349344528;1984.6328429240637;2034.6235946349973;2063.8245749111343;97368;129241;130776;133680.33159834237;135084;16737;17432.38986635487;19505.512362190773;20384.490387740425;21120;34650.3222065018;34729.82635086859;34742;34808.651913481044;34904.65095349065;8785.516796576121;10286.457031445343;10541.20940929418;10682.465876706134;10882.727931801768;7088.893666595005;8752.8687069694;8773.868391974125;8935.731928042169;8956.984678447427;7877.724279650185;7908.841823163504;9269.397489163182;9601.951990240004;9677.83852943227;3079.4303053935096;3626.437902125175;3662.5238718966366;3681.392570225936;3699.260147970363;881.7927786970057;943.9433633981984;979.4955597867104;980.7155924781877;1056.3767377247307;16655.91672041632;20182.495437613885;20217.090230939644;21404;22425.973844673223;888.8666699995052;920.3419555018194;931.3201363005044;983.8770153730784;999.1557134221571;9409.576569054409;11489.310641361544;11548.364839933884;11554.133439992034;11648.359340236368;579292;579364;582830;605744;610508;76117;79076.41847163024;129364.43684847046;139777;141097;973.1582181413027;1007.4408703169664;1037.7198156497855;1055.8469021991768;1059.2849826367171;17238.482845514656;19098.663093583316;19845.900770496057;20142;20205.69691454659;45265.32102018538;46378.84052898704;53342.466575335304;55516;55556;55131.44868551424;83378;83562.58218708867;83737;84262;7923.415316936521;8151.266386025286;8205.71280005197;8264.421490495608;8380;10362.326448780805;11618.257261410856;12050.578229762266;12687.365631718561;13122.60632181036;10287.794244115226;10353.275270730977;10403.58385664565;10647.89352106469;11208.775824483628;10122.949385253027;10214.846777298199;10811.837822432513;11112.388818615054;11578.94210528942;11293.378864162221;11491.885081149081;11753.529858805552;11842.467088980844;11948.34284114382;6668.733250670113;6958.756443524655;7272.345488906024;7352.96323518379;7544.547327160388;8829.955850220966;9847.45838978863;10952.397618131079;11429.771404571695;11494.367809770209 20:02:45 INFO - PROCESS | 1948 | |3;mootools.html;1360.0343755933286;1417.2984372735493;1500.9718342935091;1698.7282034874422;1895.185070419719;7915.525068495887;8395.244428001479;8516.701915432961;8915.955420222906;8934.642614295437;8732.214100730933;8827.337949653785;8833.95583022084;8837.602307896144;8854.335924805633;2309.595820731374;2339.836211465198;2340;2341.1571834139695;2346.0615753698485;2278.7493375728654;2305.8847057647135;2329.219711396684;2329.77867102625;2330.1029103795076;2297.3452566018686;2312.9537409251807;2321.94195145121;2334.4514039200776;2342.9573839641366;2277.222802047622;2307.746147923727;2311.2141871763515;2316.6177580699164;2321.1759825261956;2295.827812914038;2296.7138402494656;2297.5404919016264;2297.7242730872404;2298.0118549023914;8753.212210900985;8799.912000880036;8803.691870784492;8860.113988601088;9067.727968160965;5219.295395121686;5364.22218778275;5371.57027437804;5379.381371142291;5395.622306438551;3566.7681600696133;3567.3757092508968;3607.188382613917;3641.563012438498;3641.672249497558;1052.0319968300369;1061.8991195836384;1067.5996501312009;1088.0425225801323;1095.3482677806771;11750.529978800838;11811.055115590732;11896.286222826659;11898.107641926803;11900.464479098462;4298.20616599213;4351.9564804352185;4534.569215924482;4536.092781443725;4548.1579960116205;9091.499967501719;9097.590608422637;9109.453432793922;9109.863352049724;9110.27117830572;5192.143296356059;5205.037068142406;5206.557442617344;5206.583473322125;5207.270982062514;4102.200070986189;4363.4763828340165;4515;4544.2501987171745;4881.243407271879;3094.226443389153;3638.3450978823535;3726.552813662378;3740.121071548184;3745.4756334113245;1132.1565433751907;1134.4554613785429;1135.074913945132;1146.0602306109076;1151.3322273081592;679.6805501414327;822.8930239068883;899.2176806178667;901.8647202919615;925.356876970499;5548.639338442988;5551.611387202857;5630.887382252332;5815.302163740378;6048.969755151196;921.9400738951947;950.7432993091827;983.3952119446632;1041.3959903256093;1069.6416700405296;3757.643023912724;3805.8097095145686;3816.3130636485143;3933.6066393361007;3984.8007599619905;10360.896391035993;10804.29772064829;10815.351078935131;10827.783444331228;10848.457577121113;10754.354738715701;10769.730756731144;10781.460926953621;10786.73033174177;10788.083012943987;8053.355731541463;8179.018517777905;8228.21831925966;8356.039055508572;8374.288185504178;5845.912311315419;5852.385499522489;5894.469497745224;5980.312264089512;6016.518678505621;9668;10214.642487512901;10247.436390998566;10262.127719143957;10285.794284114425;7971.601419928865;9289.349745518019;9644.228461722905;10264.846027309446;10343.172546196436;6243.937560624336;7063.505554611128;7248.855022899407;7361.190269070505;7638.274363935418;8303.833923321621;8318.792030199293;8347.749567512985;8408.327333813402;8422.789430264047;7580.9620951894885;7622.428317876293;7638.465307428649;7643.808904777425;7702.730404435818;7376.557406555624;7406.296401841816;7470.2903224193615;7569.432292577969;7651.0818701753915;6729.9473660534;6823.351781580742;6842.863142737217;6852.451803855779;7063.223045464892;4865.9756701216265;4880.682755620874;4919.508049195195;4974.726390048582;5139.357580302462;4989.975050124726;4992.375953005874;5051.318072060225;5051.469595692546;5212.582993360598 20:02:45 INFO - PROCESS | 1948 | |4;prototype.html;299.8141152485459;305.47763324714737;307.33002055518966;314.1329929394871;318.0934337139152;4452;5361.892762144755;5433;5436.72816359182;5474.671519708821;5306.310179676637;5311.893762124755;5348.117560602505;5412.161115027167;5412.296401467814;3475.9304813903705;3834.846606135758;3970.5977883380574;4003.6196561326774;4018.0155861813896;3715.8699445519414;4009.278329900617;4040.939385909214;4042.7265411395315;4115.938260926088;3985.163115745697;4000.7799571023584;4020.4773379460776;4021.968905702616;4023.839046438139;3244.156519304998;3254.5769050023464;3737.9626203737885;3852.460655508231;3998.9200215995807;2892.363679990399;3324.434846076173;3478.7912725236565;3498.2828520153307;3513.789172649649;4159.772867004241;4962.826301079481;5104.591632669378;5143.639945203838;5145.485451454862;3635.7273204509765;4310.978445107786;4416.3596278539435;4448.621867141297;4456.509783923766;4390.8902277443;4643.674942754009;5238.764255608468;5654.180143879114;5706.686132262724;3941.369380899071;3978;3980.641742243212;3981.7855554056;3982.566276140587;4939.753012349404;5769.778635225469;5945.672987985659;5985.700714964278;5999.880002399971;3559.3059353425833;3967.147063381387;4020.3768415895584;4026.516817981861;4064.9390259146135;4132.5122955735915;4135.0902801383645;4142.813573389205;4146.108586653823;4149.585041495826;4150.335946248586;4750.192467280571;4755.216793702361;4776.785044672998;4781.6891902026255;5414.83755487336;5589.776408943678;5665.206871038058;5699.287589051369;5723.685197314105;1378.9310534473236;1392.7005693775886;1395.4557722488237;1396.413506327345;1399.2164387942785;818.4966245758816;827.759949614605;828.5153185386616;876.8425678104841;879.3361012435698;4178.519470260898;4576.496585375606;5087.694738315713;5226.97386513065;5238.292830467838;5104.719240441737;5726.942730572641;5782.219400380979;5812.564057695689;5833.912491312633;4832.782524786393;4881.731504767272;5190.714510701948;5194.870128246748;5246.921296180561;2546.962430055985;2644.867756612162;2956.586077949089;3056.5720799088144;3059.7399221066457;5005.6996580205305;5856.853578660568;5864.70676466175;5869.589128761031;5912.674802885796;5226.712530810766;5537.501624853782;5854.707264636836;5901.793437229677;5968.432998865101;5401.569293817798;5803.158542011384;5826.756698671043;5875.4124587541755;5895.587308888336;4493.73037617744;4967.4535801062575;5698.1452782083015;5728.885422291448;5759.94240057594;4741.786619602057;4980.377452818398;5650.773969041193;5701.258836351248;5713.514890810694;4712.835050773207;5870.61840980352;5870.9412905870395;5918.378570250062;5922.230110085661;3357.539470330414;3428.3201231395938;3592.724582773078;3725.944110838394;4019.9950012496874;4693;5028.899422011613;5205.193195054772;5245.842624721265;5807.622504537191;5374.893850841794;5582.827606202581;5612.831615051555;5614.5789065821045;5676.51749601272;4335.393044973644;4569.931451028171;4652.883677908079;5402.51377376038;5659.311826882198;5465.016297066566;5524.558035357081;5527.2538207343105;5530.281063461724;5621.919889640859;5245.265662807134;5327.147656374961;5494.313210848644;5549.306336707911;5583.413741557078;5053.823116190915;5059.584780273374;5525.668459892419;5565.55475561946;5577.832665020056 20:02:45 INFO - PROCESS | 1948 | |5;yui.html;721.9566825990441;733.0969361329136;756.557413912861;810.8864758933751;811.5495899775622;14923.552293431187;15459.922700386482;15473.148976806271;15474.84525154751;15496.612584685374;13912.304384780746;13984.160950342986;14015;14017.859821401782;14385.92807035966;668.4585485756528;688.6522306235369;689.3244620272136;819.4755356571814;831.4927893984665;847.9024912135121;855.3499340501232;860.7848037990502;866.5450638414819;869.1916517638593;910.2444970674358;910.7495438754329;911.9544022798867;915.5788337364787;918.3800934369274;698.0924797762888;726.4333819620705;905.9139381758755;906.4380084347714;910.8588168833775;652.8302641313245;673.1047706550277;674.2482132422314;674.9774092250245;678.3826717686882;14422.206778627171;14480.348384322731;14483.710325793425;14509.492167774077;14513.637159071108;13147;13464.192148471026;13539.526116585872;13625.659358516017;14059.718805623932;11054;12139.575114870937;12289;12503.937480312541;12533.185342952771;4543.7728113594185;4556.248219043854;4563.315502674593;4576.222042252825;4620.283856002325;104537.43193852174;112063.43968280188;113198.86801131966;113295;113821.43089284583;10558.208134389952;10743.14054875608;10854.78290434187;10863.130949524018;11052.115830733523;20999.580008399746;21015;21353.14587416486;21392.14431422726;21401.67897481539;7673.309402153833;7752.651130699132;7772.7668169954995;7792.454528182972;7993.760187194393;4257.6168144867115;4310.892227694333;4332.805023773938;4336.111097225062;4415.4259946206785;3381.289929114864;3490.0402389343135;3492.777527865227;3498.038039539147;3498.5451891253974;546.9808556700497;655.924568674599;662.5395350231543;662.9171353580803;663.3731124087691;549.7004132747662;550.754914063246;609.969501524922;628.4783629587431;654.1822721598003;8491.405601607828;8896.644134234688;9165.770855728526;10044.017011309421;10245.222357569408;637.9681015949184;641.493220355923;650.6649075726004;692.9168499780059;701.2881924846286;4215.430916826251;4618.445786505641;5031.7857446054095;5111.744412779346;5165.1219292720325;160212;163555.18222408812;168020.39847011524;170196;174303.89936352166;89086.55456722804;96135.51932240294;131340.3432982829;139542.3022884879;148032;97586;108093;108389;123538.99837027727;131252;9392.67125650599;9545.522723863918;9592.299882547297;9837.360176734368;9838.508074596384;44810.10379792451;55181.44818551763;60457.69771151116;60988.08517872147;63617.36382636114;72736.63631681808;75752.62123689346;85872;92271;93791;13252;13376.598702038955;13399.933000335326;13517.188968661912;13642.181469111885;14890.329935152728;14993;15055;15062.849371506145;15366.231688415759;12338.444769985552;12675.985921126103;13869.583912482642;14067.507637233057;14095.647608809863;13302.600921972356;13608.591742247749;13791.51729689456;14265.001449898407;14279.357428915931;13133.868661313265;13251;13398.799018014932;13456.259905704888;13709.657258568615;7917.604119794102;9070.773230669287;10164.33931794431;11143.498542565441;11807.527698891949;11175.017274548798;11187.440627968732;11401.087912966777;11404.315741055563;11452.198346115692 20:02:45 INFO - PROCESS | 1948 | __end_tp_report 20:02:45 INFO - PROCESS | 1948 | __start_cc_report 20:02:45 INFO - PROCESS | 1948 | _x_x_mozilla_cycle_collect,1344 20:02:45 INFO - PROCESS | 1948 | __end_cc_report 20:02:45 INFO - PROCESS | 1948 | __startTimestamp1475636565072__endTimestamp 20:02:45 INFO - PROCESS | 1948 | 20:02:45 INFO - PROCESS | 1948 | ------- Summary: start ------- 20:02:45 INFO - PROCESS | 1948 | Number of tests: 6 20:02:45 INFO - PROCESS | 1948 | 20:02:45 INFO - PROCESS | 1948 | [#0] dojo.html Cycles:165 Average:5706.44 Median:5881.47 stddev:636.53 (10.8%) stddev-sans-first:594.93 20:02:45 INFO - PROCESS | 1948 | Values: 2756.4 3264.2 3315.1 3335.3 3336.1 5606.7 5609.6 5672.3 5702.4 5714.1 5679.3 5703.3 5778.5 5789.4 5804.6 4999.3 5131.4 5157.4 5193.1 5194.2 5162.6 5294.7 5299.7 5318.6 5326.8 5255.8 5265.6 5288.6 5342.4 5358.9 5083.7 5119.6 5153.6 5165.6 5207.5 5081.3 5129.1 5149.8 5193.9 5198.6 5651.2 5697.8 5699.1 5742.8 5757.1 6075.5 6107.9 6134.3 6136.5 6151.5 6114.4 6134.3 6138.5 6160.8 6172.0 5798.1 5802.4 5803.9 5813.4 5839.4 6065.8 6167.5 6211.7 6250.3 6251.4 5639.4 5653.3 6113.3 6134.8 6157.4 6162.0 6166.6 6181.6 6183.1 6192.4 6110.9 6116.6 6168.8 6185.3 6192.8 6095.5 6103.1 6128.6 6129.2 6165.9 4888.1 4927.1 4941.5 4966.9 4970.6 4392.5 4411.2 4414.8 4421.6 4460.2 5562.9 5665.3 5690.5 5696.7 5753.3 6149.3 6159.9 6195.8 6208.8 6216.9 5708.0 5715.9 5719.4 5719.4 5751.1 5356.5 5359.9 5360.4 5363.2 5381.4 6147.7 6149.1 6151.0 6196.6 6208.4 6155.3 6243.7 6246.3 6256.2 6272.4 6229.2 6240.2 6257.5 6258.8 6260.7 6062.9 6097.2 6103.9 6116.7 6176.6 6138.5 6203.2 6227.6 6230.8 6232.4 6046.5 6089.7 6113.5 6118.0 6124.1 5949.9 6004.3 6066.7 6094.2 6117.0 5828.6 5910.3 5990.5 6003.8 6083.8 6057.2 6092.9 6093.5 6106.8 6108.8 5796.4 5817.5 5823.8 5854.3 5881.5 20:02:45 INFO - PROCESS | 1948 | 20:02:45 INFO - PROCESS | 1948 | [#1] ext.html Cycles:180 Average:66849.11 Median:37988.43 stddev:145362.12 (382.6%) stddev-sans-first:145684.43 20:02:45 INFO - PROCESS | 1948 | Values: 459.9 496.9 530.9 532.3 536.0 30424.2 39736.2 41148.0 41221.4 41261.4 39870.6 41328.8 41630.8 41734.8 41758.6 8701.4 9692.6 9839.2 9860.2 9864.0 8794.1 11898.4 12187.9 12213.5 12283.6 12139.3 12206.1 12212.3 12234.0 12235.6 8848.8 9066.6 12117.9 12175.1 12222.8 7613.5 7627.6 7700.2 11739.5 12133.6 40067.8 40508.2 40508.4 40540.0 40545.0 3279.2 3336.0 3401.6 3554.7 3590.7 30022.8 30400.8 31215.8 31298.0 31331.4 3293.1 3328.3 3341.0 3392.2 3402.2 369507.0 373314.0 374295.1 375156.0 375361.1 55578.7 55886.7 55979.6 55987.0 56036.7 59133.1 59144.0 59165.1 59226.7 59264.4 13197.9 15294.8 15679.8 15695.9 15698.1 10944.1 11220.3 12227.5 12342.6 12434.3 14741.2 15105.5 15115.2 15122.1 15128.0 5447.8 6260.9 6608.9 7044.5 7044.9 894.4 952.2 970.1 1022.1 1036.2 23903.0 27253.3 27343.0 30107.7 30263.0 1038.0 1039.4 1071.5 1075.9 1215.4 12752.0 15366.3 15478.5 15509.7 15684.1 630345.0 633408.0 635947.0 637817.0 639368.0 55300.7 55408.4 55535.0 55670.4 55812.0 1355.4 1358.5 1368.2 1368.4 1373.6 26252.8 28309.0 28447.7 29012.7 30121.9 47990.0 48543.0 48580.5 48592.5 48644.5 582811.0 583029.0 585198.0 589225.2 589772.0 38201.6 38662.6 39467.0 39579.0 39646.8 45869.5 46552.8 46813.8 47256.5 47415.8 37130.0 38160.6 38194.4 39329.8 39781.8 37844.0 38185.6 38268.0 39150.8 39564.4 31394.7 37088.0 38132.9 38297.6 38322.8 30509.9 31188.8 33831.5 34196.0 34260.8 22550.7 25146.1 25187.7 25715.0 25975.0 20:02:45 INFO - PROCESS | 1948 | 20:02:45 INFO - PROCESS | 1948 | [#2] jquery.html Cycles:180 Average:35780.38 Median:34735.91 stddev:98574.06 (283.8%) stddev-sans-first:98814.69 20:02:45 INFO - PROCESS | 1948 | Values: 353.6 364.5 372.6 380.5 401.7 12373.4 13122.7 16218.4 20538.4 20997.6 17068.8 18366.7 19911.4 20353.4 21326.3 5868.6 6095.7 6122.6 6192.3 6193.6 5030.9 6198.5 6217.9 6228.4 6250.4 6189.2 6192.0 6208.8 6210.8 7610.2 7777.3 7837.9 7954.9 8076.7 8081.5 7796.6 7882.6 7884.3 7888.4 7896.3 25193.0 27136.6 27561.6 28393.9 28749.0 2358.8 2422.6 2527.7 3041.6 3245.7 15472.9 15670.7 17317.7 17564.6 17573.7 1959.0 1970.2 1984.6 2034.6 2063.8 97368.0 129241.0 130776.0 133680.3 135084.0 16737.0 17432.4 19505.5 20384.5 21120.0 34650.3 34729.8 34742.0 34808.7 34904.7 8785.5 10286.5 10541.2 10682.5 10882.7 7088.9 8752.9 8773.9 8935.7 8957.0 7877.7 7908.8 9269.4 9602.0 9677.8 3079.4 3626.4 3662.5 3681.4 3699.3 881.8 943.9 979.5 980.7 1056.4 16655.9 20182.5 20217.1 21404.0 22426.0 888.9 920.3 931.3 983.9 999.2 9409.6 11489.3 11548.4 11554.1 11648.4 579292.0 579364.0 582830.0 605744.0 610508.0 76117.0 79076.4 129364.4 139777.0 141097.0 973.2 1007.4 1037.7 1055.8 1059.3 17238.5 19098.7 19845.9 20142.0 20205.7 45265.3 46378.8 53342.5 55516.0 55556.0 55131.4 83378.0 83562.6 83737.0 84262.0 7923.4 8151.3 8205.7 8264.4 8380.0 10362.3 11618.3 12050.6 12687.4 13122.6 10287.8 10353.3 10403.6 10647.9 11208.8 10122.9 10214.8 10811.8 11112.4 11578.9 11293.4 11491.9 11753.5 11842.5 11948.3 6668.7 6958.8 7272.3 7353.0 7544.5 8830.0 9847.5 10952.4 11429.8 11494.4 20:02:45 INFO - PROCESS | 1948 | 20:02:45 INFO - PROCESS | 1948 | [#3] mootools.html Cycles:180 Average:5650.22 Median:4947.12 stddev:3199.61 (64.7%) stddev-sans-first:3192.34 20:02:45 INFO - PROCESS | 1948 | Values: 1360.0 1417.3 1501.0 1698.7 1895.2 7915.5 8395.2 8516.7 8916.0 8934.6 8732.2 8827.3 8834.0 8837.6 8854.3 2309.6 2339.8 2340.0 2341.2 2346.1 2278.7 2305.9 2329.2 2329.8 2330.1 2297.3 2313.0 2321.9 2334.5 2343.0 2277.2 2307.7 2311.2 2316.6 2321.2 2295.8 2296.7 2297.5 2297.7 2298.0 8753.2 8799.9 8803.7 8860.1 9067.7 5219.3 5364.2 5371.6 5379.4 5395.6 3566.8 3567.4 3607.2 3641.6 3641.7 1052.0 1061.9 1067.6 1088.0 1095.3 11750.5 11811.1 11896.3 11898.1 11900.5 4298.2 4352.0 4534.6 4536.1 4548.2 9091.5 9097.6 9109.5 9109.9 9110.3 5192.1 5205.0 5206.6 5206.6 5207.3 4102.2 4363.5 4515.0 4544.3 4881.2 3094.2 3638.3 3726.6 3740.1 3745.5 1132.2 1134.5 1135.1 1146.1 1151.3 679.7 822.9 899.2 901.9 925.4 5548.6 5551.6 5630.9 5815.3 6049.0 921.9 950.7 983.4 1041.4 1069.6 3757.6 3805.8 3816.3 3933.6 3984.8 10360.9 10804.3 10815.4 10827.8 10848.5 10754.4 10769.7 10781.5 10786.7 10788.1 8053.4 8179.0 8228.2 8356.0 8374.3 5845.9 5852.4 5894.5 5980.3 6016.5 9668.0 10214.6 10247.4 10262.1 10285.8 7971.6 9289.3 9644.2 10264.8 10343.2 6243.9 7063.5 7248.9 7361.2 7638.3 8303.8 8318.8 8347.7 8408.3 8422.8 7581.0 7622.4 7638.5 7643.8 7702.7 7376.6 7406.3 7470.3 7569.4 7651.1 6729.9 6823.4 6842.9 6852.5 7063.2 4866.0 4880.7 4919.5 4974.7 5139.4 4990.0 4992.4 5051.3 5051.5 5212.6 20:02:45 INFO - PROCESS | 1948 | 20:02:45 INFO - PROCESS | 1948 | [#4] prototype.html Cycles:180 Average:4496.05 Median:5041.36 stddev:1387.52 (27.5%) stddev-sans-first:1355.19 20:02:45 INFO - PROCESS | 1948 | Values: 299.8 305.5 307.3 314.1 318.1 4452.0 5361.9 5433.0 5436.7 5474.7 5306.3 5311.9 5348.1 5412.2 5412.3 3475.9 3834.8 3970.6 4003.6 4018.0 3715.9 4009.3 4040.9 4042.7 4115.9 3985.2 4000.8 4020.5 4022.0 4023.8 3244.2 3254.6 3738.0 3852.5 3998.9 2892.4 3324.4 3478.8 3498.3 3513.8 4159.8 4962.8 5104.6 5143.6 5145.5 3635.7 4311.0 4416.4 4448.6 4456.5 4390.9 4643.7 5238.8 5654.2 5706.7 3941.4 3978.0 3980.6 3981.8 3982.6 4939.8 5769.8 5945.7 5985.7 5999.9 3559.3 3967.1 4020.4 4026.5 4064.9 4132.5 4135.1 4142.8 4146.1 4149.6 4150.3 4750.2 4755.2 4776.8 4781.7 5414.8 5589.8 5665.2 5699.3 5723.7 1378.9 1392.7 1395.5 1396.4 1399.2 818.5 827.8 828.5 876.8 879.3 4178.5 4576.5 5087.7 5227.0 5238.3 5104.7 5726.9 5782.2 5812.6 5833.9 4832.8 4881.7 5190.7 5194.9 5246.9 2547.0 2644.9 2956.6 3056.6 3059.7 5005.7 5856.9 5864.7 5869.6 5912.7 5226.7 5537.5 5854.7 5901.8 5968.4 5401.6 5803.2 5826.8 5875.4 5895.6 4493.7 4967.5 5698.1 5728.9 5759.9 4741.8 4980.4 5650.8 5701.3 5713.5 4712.8 5870.6 5870.9 5918.4 5922.2 3357.5 3428.3 3592.7 3725.9 4020.0 4693.0 5028.9 5205.2 5245.8 5807.6 5374.9 5582.8 5612.8 5614.6 5676.5 4335.4 4569.9 4652.9 5402.5 5659.3 5465.0 5524.6 5527.3 5530.3 5621.9 5245.3 5327.1 5494.3 5549.3 5583.4 5053.8 5059.6 5525.7 5565.6 5577.8 20:02:45 INFO - PROCESS | 1948 | 20:02:45 INFO - PROCESS | 1948 | [#5] yui.html Cycles:180 Average:24921.11 Median:3498.29 stddev:40871.71 (1168.3%) stddev-sans-first:40945.97 20:02:45 INFO - PROCESS | 1948 | Values: 722.0 733.1 756.6 810.9 811.5 14923.6 15459.9 15473.1 15474.8 15496.6 13912.3 13984.2 14015.0 14017.9 14385.9 668.5 688.7 689.3 819.5 831.5 847.9 855.3 860.8 866.5 869.2 910.2 910.7 912.0 915.6 918.4 698.1 726.4 905.9 906.4 910.9 652.8 673.1 674.2 675.0 678.4 14422.2 14480.3 14483.7 14509.5 14513.6 13147.0 13464.2 13539.5 13625.7 14059.7 11054.0 12139.6 12289.0 12503.9 12533.2 4543.8 4556.2 4563.3 4576.2 4620.3 104537.4 112063.4 113198.9 113295.0 113821.4 10558.2 10743.1 10854.8 10863.1 11052.1 20999.6 21015.0 21353.1 21392.1 21401.7 7673.3 7752.7 7772.8 7792.5 7993.8 4257.6 4310.9 4332.8 4336.1 4415.4 3381.3 3490.0 3492.8 3498.0 3498.5 547.0 655.9 662.5 662.9 663.4 549.7 550.8 610.0 628.5 654.2 8491.4 8896.6 9165.8 10044.0 10245.2 638.0 641.5 650.7 692.9 701.3 4215.4 4618.4 5031.8 5111.7 5165.1 160212.0 163555.2 168020.4 170196.0 174303.9 89086.6 96135.5 131340.3 139542.3 148032.0 97586.0 108093.0 108389.0 123539.0 131252.0 9392.7 9545.5 9592.3 9837.4 9838.5 44810.1 55181.4 60457.7 60988.1 63617.4 72736.6 75752.6 85872.0 92271.0 93791.0 13252.0 13376.6 13399.9 13517.2 13642.2 14890.3 14993.0 15055.0 15062.8 15366.2 12338.4 12676.0 13869.6 14067.5 14095.6 13302.6 13608.6 13791.5 14265.0 14279.4 13133.9 13251.0 13398.8 13456.3 13709.7 7917.6 9070.8 10164.3 11143.5 11807.5 11175.0 11187.4 11401.1 11404.3 11452.2 20:02:45 INFO - PROCESS | 1948 | -------- Summary: end -------- 20:02:45 INFO - PROCESS | 1948 | 20:02:45 INFO - TEST-INFO | 1948: exit 0 20:02:45 INFO - TEST-OK | dromaeo_css | took 1118609ms 20:02:45 INFO - TEST-START | kraken 20:02:45 INFO - operating with platform_type : mac_ 20:02:45 INFO - Initialising browser for kraken test... 20:02:45 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmp09pacO/profile http://localhost:49444/getInfo.html) 20:02:47 INFO - PROCESS | 1951 | __metrics Screen width/height:1600/1200 20:02:47 INFO - PROCESS | 1951 | colorDepth:24 20:02:47 INFO - PROCESS | 1951 | Browser inner width/height: 1024/689 20:02:47 INFO - PROCESS | 1951 | __metrics 20:02:48 INFO - PROCESS | 1951 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:02:48 INFO - PROCESS | 1951 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:02:48 INFO - TEST-INFO | 1951: exit 0 20:02:48 INFO - Browser initialized. 20:02:48 INFO - Running cycle 1/1 for kraken test... 20:02:48 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmp09pacO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:03:00 INFO - PROCESS | 1952 | RSS: Main: 235630592 20:03:00 INFO - PROCESS | 1952 | 20:03:03 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49444/tests/kraken/driver.html?testName=audio-beat-detection) 20:03:04 INFO - PROCESS | 1952 | RSS: Main: 294129664 20:03:04 INFO - PROCESS | 1952 | 20:03:06 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49444/tests/kraken/driver.html?testName=audio-dft) 20:03:07 INFO - PROCESS | 1952 | RSS: Main: 293076992 20:03:07 INFO - PROCESS | 1952 | 20:03:11 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49444/tests/kraken/driver.html?testName=audio-fft) 20:03:11 INFO - PROCESS | 1952 | RSS: Main: 384131072 20:03:11 INFO - PROCESS | 1952 | 20:03:13 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49444/tests/kraken/driver.html?testName=audio-oscillator) 20:03:14 INFO - PROCESS | 1952 | RSS: Main: 284532736 20:03:14 INFO - PROCESS | 1952 | 20:03:16 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49444/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:03:16 INFO - PROCESS | 1952 | RSS: Main: 290033664 20:03:16 INFO - PROCESS | 1952 | 20:03:19 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49444/tests/kraken/driver.html?testName=imaging-darkroom) 20:03:20 INFO - PROCESS | 1952 | RSS: Main: 326074368 20:03:20 INFO - PROCESS | 1952 | 20:03:23 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49444/tests/kraken/driver.html?testName=imaging-desaturate) 20:03:23 INFO - PROCESS | 1952 | RSS: Main: 330297344 20:03:23 INFO - PROCESS | 1952 | 20:03:26 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49444/tests/kraken/driver.html?testName=json-parse-financial) 20:03:27 INFO - PROCESS | 1952 | RSS: Main: 327454720 20:03:27 INFO - PROCESS | 1952 | 20:03:28 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49444/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:03:29 INFO - PROCESS | 1952 | RSS: Main: 303411200 20:03:29 INFO - PROCESS | 1952 | 20:03:31 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:03:31 INFO - PROCESS | 1952 | RSS: Main: 304603136 20:03:31 INFO - PROCESS | 1952 | 20:03:34 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:03:34 INFO - PROCESS | 1952 | RSS: Main: 313589760 20:03:34 INFO - PROCESS | 1952 | 20:03:37 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:03:38 INFO - PROCESS | 1952 | RSS: Main: 318509056 20:03:38 INFO - PROCESS | 1952 | 20:03:41 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:03:41 INFO - PROCESS | 1952 | RSS: Main: 318566400 20:03:41 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49444/tests/kraken/driver.html?testName=ai-astar) 20:03:43 INFO - PROCESS | 1952 | RSS: Main: 362033152 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | __start_tp_report 20:03:43 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 20:03:43 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 20:03:43 INFO - PROCESS | 1952 | |i|pagename|runs| 20:03:43 INFO - PROCESS | 1952 | |0;ai-astar;114;110;114;112;112;114;113;113;112;109 20:03:43 INFO - PROCESS | 1952 | |1;audio-beat-detection;149;114;114;151;116;115;142;143;168;113 20:03:43 INFO - PROCESS | 1952 | |2;audio-dft;183;183;183;182;186;184;180;181;180;185 20:03:43 INFO - PROCESS | 1952 | |3;audio-fft;79;60;58;88;60;59;60;58;82;57 20:03:43 INFO - PROCESS | 1952 | |4;audio-oscillator;89;71;92;71;68;69;92;67;69;90 20:03:43 INFO - PROCESS | 1952 | |5;imaging-gaussian-blur;87;85;88;85;87;84;88;85;89;130 20:03:43 INFO - PROCESS | 1952 | |6;imaging-darkroom;94;93;93;93;94;93;93;93;94;93 20:03:43 INFO - PROCESS | 1952 | |7;imaging-desaturate;86;86;86;86;86;84;86;85;84;84 20:03:43 INFO - PROCESS | 1952 | |8;json-parse-financial;55;55;53;54;54;55;53;54;53;54 20:03:43 INFO - PROCESS | 1952 | |9;json-stringify-tinderbox;64;72;71;76;72;68;70;71;71;72 20:03:43 INFO - PROCESS | 1952 | |10;stanford-crypto-aes;86;84;87;88;89;90;85;92;92;108 20:03:43 INFO - PROCESS | 1952 | |11;stanford-crypto-ccm;144;145;148;153;158;152;156;166;211;159 20:03:43 INFO - PROCESS | 1952 | |12;stanford-crypto-pbkdf2;173;170;172;172;171;168;185;174;170;172 20:03:43 INFO - PROCESS | 1952 | |13;stanford-crypto-sha256-iterative;69;69;69;68;68;70;70;69;70;68 20:03:43 INFO - PROCESS | 1952 | __end_tp_report 20:03:43 INFO - PROCESS | 1952 | __start_cc_report 20:03:43 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,1953 20:03:43 INFO - PROCESS | 1952 | __end_cc_report 20:03:43 INFO - PROCESS | 1952 | __startTimestamp1475636623936__endTimestamp 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | ------- Summary: start ------- 20:03:43 INFO - PROCESS | 1952 | Number of tests: 14 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.70 (1.5%) stddev-sans-first:1.69 20:03:43 INFO - PROCESS | 1952 | Values: 114.0 110.0 114.0 112.0 112.0 114.0 113.0 113.0 112.0 109.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:142.50 stddev:20.33 (14.3%) stddev-sans-first:20.66 20:03:43 INFO - PROCESS | 1952 | Values: 149.0 114.0 114.0 151.0 116.0 115.0 142.0 143.0 168.0 113.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:2.00 (1.1%) stddev-sans-first:2.12 20:03:43 INFO - PROCESS | 1952 | Values: 183.0 183.0 183.0 182.0 186.0 184.0 180.0 181.0 180.0 185.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.00 stddev:11.90 (19.8%) stddev-sans-first:11.67 20:03:43 INFO - PROCESS | 1952 | Values: 79.0 60.0 58.0 88.0 60.0 59.0 60.0 58.0 82.0 57.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:80.00 stddev:11.24 (14.1%) stddev-sans-first:11.17 20:03:43 INFO - PROCESS | 1952 | Values: 89.0 71.0 92.0 71.0 68.0 69.0 92.0 67.0 69.0 90.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:87.00 stddev:13.87 (15.9%) stddev-sans-first:14.64 20:03:43 INFO - PROCESS | 1952 | Values: 87.0 85.0 88.0 85.0 87.0 84.0 88.0 85.0 89.0 130.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 20:03:43 INFO - PROCESS | 1952 | Values: 94.0 93.0 93.0 93.0 94.0 93.0 93.0 93.0 94.0 93.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:0.95 (1.1%) stddev-sans-first:0.97 20:03:43 INFO - PROCESS | 1952 | Values: 86.0 86.0 86.0 86.0 86.0 84.0 86.0 85.0 84.0 84.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.78 20:03:43 INFO - PROCESS | 1952 | Values: 55.0 55.0 53.0 54.0 54.0 55.0 53.0 54.0 53.0 54.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.50 stddev:3.09 (4.3%) stddev-sans-first:2.13 20:03:43 INFO - PROCESS | 1952 | Values: 64.0 72.0 71.0 76.0 72.0 68.0 70.0 71.0 71.0 72.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:88.50 stddev:6.85 (7.7%) stddev-sans-first:7.11 20:03:43 INFO - PROCESS | 1952 | Values: 86.0 84.0 87.0 88.0 89.0 90.0 85.0 92.0 92.0 108.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#11] stanford-crypto-ccm Cycles:10 Average:159.20 Median:157.00 stddev:19.41 (12.4%) stddev-sans-first:19.79 20:03:43 INFO - PROCESS | 1952 | Values: 144.0 145.0 148.0 153.0 158.0 152.0 156.0 166.0 211.0 159.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:172.00 stddev:4.64 (2.7%) stddev-sans-first:4.92 20:03:43 INFO - PROCESS | 1952 | Values: 173.0 170.0 172.0 172.0 171.0 168.0 185.0 174.0 170.0 172.0 20:03:43 INFO - PROCESS | 1952 | 20:03:43 INFO - PROCESS | 1952 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 20:03:43 INFO - PROCESS | 1952 | Values: 69.0 69.0 69.0 68.0 68.0 70.0 70.0 69.0 70.0 68.0 20:03:43 INFO - PROCESS | 1952 | -------- Summary: end -------- 20:03:43 INFO - PROCESS | 1952 | 20:03:44 INFO - TEST-INFO | 1952: exit 0 20:03:44 INFO - TEST-OK | kraken | took 59070ms 20:03:44 INFO - SUITE-END | took 1177s 20:03:45 INFO - Completed test suite (00:19:37) 20:03:45 INFO - javascript benchmark 20:03:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2756.4487102579483, 3264.151320656629, 3315.1214928044055, 3335.3329334133177, 3336.099253201637, 5606.663600183992, 5609.635373700712, 5672.290963629546, 5702.4012478689765, 5714.057180565207, 5679.261695979527, 5703.3441154267275, 5778.4799368056865, 5789.39211382804, 5804.622699524539, 4999.325091112708, 5131.409887862887, 5157.4068982067165, 5193.091209038422, 5194.246834209038, 5162.638615296931, 5294.682319060849, 5299.655522391052, 5318.6011049171275, 5326.760295786679, 5255.789768409298, 5265.631405801595, 5288.5504732097625, 5342.385625653042, 5358.946410535884, 5083.694978301313, 5119.641625086246, 5153.56194723449, 5165.560927321182, 5207.4792520748, 5081.28861959326, 5129.0767661820855, 5149.794008239666, 5193.948060519384, 5198.5841132709675, 5651.18057881609, 5697.77208911643, 5699.116636921284, 5742.799002034951, 5757.050086735683, 6075.453209211148, 6107.886786452505, 6134.263888333428, 6136.539759518054, 6151.507879369639, 6114.409200427198, 6134.294556126058, 6138.549551575117, 6160.815175544741, 6172.0, 5798.130280457881, 5802.419758024248, 5803.941960580382, 5813.447722466359, 5839.416058394169, 6065.848353791102, 6167.506599472032, 6211.720472578654, 6250.312465628777, 6251.374862513803, 5639.407862174495, 5653.349864765604, 6113.266408031065, 6134.78528251509, 6157.4458298753325, 6162.0, 6166.630002199882, 6181.567290289637, 6183.072539119168, 6192.442680158807, 6110.877782444326, 6116.633002019893, 6168.845778855564, 6185.257769067741, 6192.81421557354, 6095.529019716752, 6103.115048317969, 6128.594790794077, 6129.20597562684, 6165.876682466325, 4888.120138375056, 4927.1131196384995, 4941.50584941503, 4966.925496117561, 4970.627202959792, 4392.494863090786, 4411.20598292304, 4414.763866117492, 4421.624161946206, 4460.241758900995, 5562.9443705563235, 5665.3201615806365, 5690.5447564194765, 5696.6582005079, 5753.252077229933, 6149.292831324455, 6159.922013647593, 6195.752169913153, 6208.844778880474, 6216.937830621727, 5707.971460142673, 5715.942840571624, 5719.399463056319, 5719.428057194331, 5751.1373294006235, 5356.491133342326, 5359.946400536022, 5360.437154098841, 5363.168708850135, 5381.4349493303425, 6147.678249176449, 6149.0776383542825, 6150.985087460698, 6196.566240363131, 6208.441240288395, 6155.261368635793, 6243.656598886923, 6246.344133865879, 6256.186695729526, 6272.40412160844, 6229.159063526366, 6240.219972503437, 6257.4994000480765, 6258.780942666985, 6260.68696565179, 6062.878742425215, 6097.207363042776, 6103.908441373472, 6116.724747386467, 6176.629402235881, 6138.541671868701, 6203.193584833943, 6227.595206311576, 6230.7819226328675, 6232.376762323732, 6046.516278697605, 6089.69551522431, 6113.510919126548, 6118.0, 6124.050772130327, 5949.851253718692, 6004.309504406874, 6066.666333351532, 6094.1773158968435, 6117.035835319669, 5828.562857785768, 5910.320313164041, 5990.460858522754, 6003.8198854034445, 6083.756649733961, 6057.212562366864, 6092.908606370819, 6093.542984276109, 6106.7862624809695, 6108.75564977396, 5796.362400136066, 5817.505512031525, 5823.79616713413, 5854.297484301911, 5881.470667639933], "value": 5663.604608312656, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.91261660284545, 496.89316796888664, 530.9044372013038, 532.3266068423443, 535.9785608575655, 30424.239394015134, 39736.20527589446, 41147.971300717494, 41221.38167927483, 41261.381079283834, 39870.60129398705, 41328.79335603325, 41630.791846040804, 41734.79132604333, 41758.58241417585, 8701.434406763572, 9692.612295508188, 9839.16367108793, 9860.161886239679, 9863.95068024659, 8794.076621954699, 11898.405079746022, 12187.939060304687, 12213.45039473226, 12283.631491055283, 12139.271643701362, 12206.145569810116, 12212.32832194229, 12234.0, 12235.632931012084, 8848.778780530474, 9066.637334506611, 12117.878821211807, 12175.0868684849, 12222.816657750096, 7613.467057305936, 7627.61861906908, 7700.152983171903, 11739.530418783239, 12133.575324863676, 40067.79966100151, 40508.189836203404, 40508.39237411441, 40540.0, 40544.98637534056, 3279.212988882675, 3336.049225970611, 3401.6088149862835, 3554.697850682695, 3590.676839084495, 30022.84988575065, 30400.84799575988, 31215.843920780477, 31298.0, 31331.37337253242, 3293.143782616537, 3328.267781088181, 3340.9665903341142, 3392.168918614955, 3402.2344972381266, 369507.0, 373314.0, 374295.1285243584, 375156.0, 375361.123194385, 55578.72210638921, 55886.72056639772, 55979.60050998758, 55987.0, 56036.719816400655, 59133.113003304985, 59144.0, 59165.112523312186, 59226.70386648039, 59264.40735592589, 13197.934010329887, 15294.847051529565, 15679.843201567839, 15695.921520392325, 15698.136602486744, 10944.124470042378, 11220.326780393203, 12227.510899564095, 12342.629721108382, 12434.316112613713, 14741.189234591986, 15105.54683359501, 15115.168665723271, 15122.09267443957, 15128.0, 5447.836564903059, 6260.906086408708, 6608.900866487006, 7044.506884518035, 7044.859102818017, 894.4141587260355, 952.1620973543238, 970.1365784451843, 1022.0545994954638, 1036.233187441303, 23903.0, 27253.318667033484, 27343.0, 30107.69892301049, 30263.0, 1037.9636712715019, 1039.417925961464, 1071.5124618298655, 1075.854759607443, 1215.392303848076, 12752.0, 15366.31089559345, 15478.458253961056, 15509.720930463996, 15684.137372444397, 630345.0, 633408.0, 635947.0, 637817.0, 639368.0, 55300.72349638226, 55408.44591554113, 55535.0, 55670.443295566525, 55812.0, 1355.3697530648296, 1358.5041459867275, 1368.2337890780996, 1368.3842270978298, 1373.642852858264, 26252.81862316162, 28309.0, 28447.715522844508, 29012.709872901, 30121.945731900156, 47990.0, 48543.0, 48580.5141948576, 48592.5140748588, 48644.513554863996, 582811.0, 583029.0, 585198.0, 589225.2154956963, 589772.0, 38201.61798381981, 38662.613373865905, 39467.01332466711, 39579.0, 39646.80176599098, 45869.54130458653, 46552.7672361636, 46813.76593117013, 47256.52743472521, 47415.762921185174, 37130.0, 38160.618393815705, 38194.427083594324, 39329.803350983064, 39781.80109099436, 37844.0, 38185.6181438182, 38268.0, 39150.80424597859, 39564.40653390259, 31394.744210231336, 37088.0, 38132.856014319615, 38297.61702382941, 38322.80838595789, 30509.93215237456, 31188.844055779577, 33831.4925276126, 34196.0, 34260.82869585636, 22550.651266156583, 25146.11988580391, 25187.74812251854, 25715.0, 25975.0], "value": 19808.210733325097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.5933676272288, 364.48425477948706, 372.6310952157365, 380.516743735456, 401.73485499570273, 12373.443195056221, 13122.737545249101, 16218.351265949363, 20538.383848484533, 20997.58004839906, 17068.82931170688, 18366.724499132524, 19911.40265792025, 20353.38939831804, 21326.253581124663, 5868.559858010655, 6095.695215239242, 6122.63264204147, 6192.287886892997, 6193.566450348478, 5030.9183525542, 6198.4731297839735, 6217.937820621781, 6228.439440450358, 6250.374962503759, 6189.195404597396, 6191.969040154815, 6208.78269260576, 6210.8447288817915, 7610.200928902468, 7777.300042996101, 7837.921620783804, 7954.920450795505, 8076.71731489395, 8081.474704144271, 7796.61016949156, 7882.566458844762, 7884.290413862723, 7888.40836937232, 7896.289333959971, 25193.0, 27136.592951105747, 27561.586576201375, 28393.858030709715, 28749.0, 2358.846674966139, 2422.5760491913843, 2527.7093134289607, 3041.6045914031256, 3245.675432456759, 15472.92263538675, 15670.686586268212, 17317.653646927116, 17564.560885977826, 17573.7363939541, 1958.9608207835906, 1970.173349344528, 1984.6328429240637, 2034.6235946349973, 2063.8245749111343, 97368.0, 129241.0, 130776.0, 133680.33159834237, 135084.0, 16737.0, 17432.38986635487, 19505.512362190773, 20384.490387740425, 21120.0, 34650.3222065018, 34729.82635086859, 34742.0, 34808.651913481044, 34904.65095349065, 8785.516796576121, 10286.457031445343, 10541.20940929418, 10682.465876706134, 10882.727931801768, 7088.893666595005, 8752.8687069694, 8773.868391974125, 8935.731928042169, 8956.984678447427, 7877.724279650185, 7908.841823163504, 9269.397489163182, 9601.951990240004, 9677.83852943227, 3079.4303053935096, 3626.437902125175, 3662.5238718966366, 3681.392570225936, 3699.260147970363, 881.7927786970057, 943.9433633981984, 979.4955597867104, 980.7155924781877, 1056.3767377247307, 16655.91672041632, 20182.495437613885, 20217.090230939644, 21404.0, 22425.973844673223, 888.8666699995052, 920.3419555018194, 931.3201363005044, 983.8770153730784, 999.1557134221571, 9409.576569054409, 11489.310641361544, 11548.364839933884, 11554.133439992034, 11648.359340236368, 579292.0, 579364.0, 582830.0, 605744.0, 610508.0, 76117.0, 79076.41847163024, 129364.43684847046, 139777.0, 141097.0, 973.1582181413027, 1007.4408703169664, 1037.7198156497855, 1055.8469021991768, 1059.2849826367171, 17238.482845514656, 19098.663093583316, 19845.900770496057, 20142.0, 20205.69691454659, 45265.32102018538, 46378.84052898704, 53342.466575335304, 55516.0, 55556.0, 55131.44868551424, 83378.0, 83562.58218708867, 83737.0, 84262.0, 7923.415316936521, 8151.266386025286, 8205.71280005197, 8264.421490495608, 8380.0, 10362.326448780805, 11618.257261410856, 12050.578229762266, 12687.365631718561, 13122.60632181036, 10287.794244115226, 10353.275270730977, 10403.58385664565, 10647.89352106469, 11208.775824483628, 10122.949385253027, 10214.846777298199, 10811.837822432513, 11112.388818615054, 11578.94210528942, 11293.378864162221, 11491.885081149081, 11753.529858805552, 11842.467088980844, 11948.34284114382, 6668.733250670113, 6958.756443524655, 7272.345488906024, 7352.96323518379, 7544.547327160388, 8829.955850220966, 9847.45838978863, 10952.397618131079, 11429.771404571695, 11494.367809770209], "value": 10685.321776761177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.0343755933286, 1417.2984372735493, 1500.9718342935091, 1698.7282034874422, 1895.185070419719, 7915.525068495887, 8395.244428001479, 8516.701915432961, 8915.955420222906, 8934.642614295437, 8732.214100730933, 8827.337949653785, 8833.95583022084, 8837.602307896144, 8854.335924805633, 2309.595820731374, 2339.836211465198, 2340.0, 2341.1571834139695, 2346.0615753698485, 2278.7493375728654, 2305.8847057647135, 2329.219711396684, 2329.77867102625, 2330.1029103795076, 2297.3452566018686, 2312.9537409251807, 2321.94195145121, 2334.4514039200776, 2342.9573839641366, 2277.222802047622, 2307.746147923727, 2311.2141871763515, 2316.6177580699164, 2321.1759825261956, 2295.827812914038, 2296.7138402494656, 2297.5404919016264, 2297.7242730872404, 2298.0118549023914, 8753.212210900985, 8799.912000880036, 8803.691870784492, 8860.113988601088, 9067.727968160965, 5219.295395121686, 5364.22218778275, 5371.57027437804, 5379.381371142291, 5395.622306438551, 3566.7681600696133, 3567.3757092508968, 3607.188382613917, 3641.563012438498, 3641.672249497558, 1052.0319968300369, 1061.8991195836384, 1067.5996501312009, 1088.0425225801323, 1095.3482677806771, 11750.529978800838, 11811.055115590732, 11896.286222826659, 11898.107641926803, 11900.464479098462, 4298.20616599213, 4351.9564804352185, 4534.569215924482, 4536.092781443725, 4548.1579960116205, 9091.499967501719, 9097.590608422637, 9109.453432793922, 9109.863352049724, 9110.27117830572, 5192.143296356059, 5205.037068142406, 5206.557442617344, 5206.583473322125, 5207.270982062514, 4102.200070986189, 4363.4763828340165, 4515.0, 4544.2501987171745, 4881.243407271879, 3094.226443389153, 3638.3450978823535, 3726.552813662378, 3740.121071548184, 3745.4756334113245, 1132.1565433751907, 1134.4554613785429, 1135.074913945132, 1146.0602306109076, 1151.3322273081592, 679.6805501414327, 822.8930239068883, 899.2176806178667, 901.8647202919615, 925.356876970499, 5548.639338442988, 5551.611387202857, 5630.887382252332, 5815.302163740378, 6048.969755151196, 921.9400738951947, 950.7432993091827, 983.3952119446632, 1041.3959903256093, 1069.6416700405296, 3757.643023912724, 3805.8097095145686, 3816.3130636485143, 3933.6066393361007, 3984.8007599619905, 10360.896391035993, 10804.29772064829, 10815.351078935131, 10827.783444331228, 10848.457577121113, 10754.354738715701, 10769.730756731144, 10781.460926953621, 10786.73033174177, 10788.083012943987, 8053.355731541463, 8179.018517777905, 8228.21831925966, 8356.039055508572, 8374.288185504178, 5845.912311315419, 5852.385499522489, 5894.469497745224, 5980.312264089512, 6016.518678505621, 9668.0, 10214.642487512901, 10247.436390998566, 10262.127719143957, 10285.794284114425, 7971.601419928865, 9289.349745518019, 9644.228461722905, 10264.846027309446, 10343.172546196436, 6243.937560624336, 7063.505554611128, 7248.855022899407, 7361.190269070505, 7638.274363935418, 8303.833923321621, 8318.792030199293, 8347.749567512985, 8408.327333813402, 8422.789430264047, 7580.9620951894885, 7622.428317876293, 7638.465307428649, 7643.808904777425, 7702.730404435818, 7376.557406555624, 7406.296401841816, 7470.2903224193615, 7569.432292577969, 7651.0818701753915, 6729.9473660534, 6823.351781580742, 6842.863142737217, 6852.451803855779, 7063.223045464892, 4865.9756701216265, 4880.682755620874, 4919.508049195195, 4974.726390048582, 5139.357580302462, 4989.975050124726, 4992.375953005874, 5051.318072060225, 5051.469595692546, 5212.582993360598], "value": 4522.1916975353215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.8141152485459, 305.47763324714737, 307.33002055518966, 314.1329929394871, 318.0934337139152, 4452.0, 5361.892762144755, 5433.0, 5436.72816359182, 5474.671519708821, 5306.310179676637, 5311.893762124755, 5348.117560602505, 5412.161115027167, 5412.296401467814, 3475.9304813903705, 3834.846606135758, 3970.5977883380574, 4003.6196561326774, 4018.0155861813896, 3715.8699445519414, 4009.278329900617, 4040.939385909214, 4042.7265411395315, 4115.938260926088, 3985.163115745697, 4000.7799571023584, 4020.4773379460776, 4021.968905702616, 4023.839046438139, 3244.156519304998, 3254.5769050023464, 3737.9626203737885, 3852.460655508231, 3998.9200215995807, 2892.363679990399, 3324.434846076173, 3478.7912725236565, 3498.2828520153307, 3513.789172649649, 4159.772867004241, 4962.826301079481, 5104.591632669378, 5143.639945203838, 5145.485451454862, 3635.7273204509765, 4310.978445107786, 4416.3596278539435, 4448.621867141297, 4456.509783923766, 4390.8902277443, 4643.674942754009, 5238.764255608468, 5654.180143879114, 5706.686132262724, 3941.369380899071, 3978.0, 3980.641742243212, 3981.7855554056, 3982.566276140587, 4939.753012349404, 5769.778635225469, 5945.672987985659, 5985.700714964278, 5999.880002399971, 3559.3059353425833, 3967.147063381387, 4020.3768415895584, 4026.516817981861, 4064.9390259146135, 4132.5122955735915, 4135.0902801383645, 4142.813573389205, 4146.108586653823, 4149.585041495826, 4150.335946248586, 4750.192467280571, 4755.216793702361, 4776.785044672998, 4781.6891902026255, 5414.83755487336, 5589.776408943678, 5665.206871038058, 5699.287589051369, 5723.685197314105, 1378.9310534473236, 1392.7005693775886, 1395.4557722488237, 1396.413506327345, 1399.2164387942785, 818.4966245758816, 827.759949614605, 828.5153185386616, 876.8425678104841, 879.3361012435698, 4178.519470260898, 4576.496585375606, 5087.694738315713, 5226.97386513065, 5238.292830467838, 5104.719240441737, 5726.942730572641, 5782.219400380979, 5812.564057695689, 5833.912491312633, 4832.782524786393, 4881.731504767272, 5190.714510701948, 5194.870128246748, 5246.921296180561, 2546.962430055985, 2644.867756612162, 2956.586077949089, 3056.5720799088144, 3059.7399221066457, 5005.6996580205305, 5856.853578660568, 5864.70676466175, 5869.589128761031, 5912.674802885796, 5226.712530810766, 5537.501624853782, 5854.707264636836, 5901.793437229677, 5968.432998865101, 5401.569293817798, 5803.158542011384, 5826.756698671043, 5875.4124587541755, 5895.587308888336, 4493.73037617744, 4967.4535801062575, 5698.1452782083015, 5728.885422291448, 5759.94240057594, 4741.786619602057, 4980.377452818398, 5650.773969041193, 5701.258836351248, 5713.514890810694, 4712.835050773207, 5870.61840980352, 5870.9412905870395, 5918.378570250062, 5922.230110085661, 3357.539470330414, 3428.3201231395938, 3592.724582773078, 3725.944110838394, 4019.9950012496874, 4693.0, 5028.899422011613, 5205.193195054772, 5245.842624721265, 5807.622504537191, 5374.893850841794, 5582.827606202581, 5612.831615051555, 5614.5789065821045, 5676.51749601272, 4335.393044973644, 4569.931451028171, 4652.883677908079, 5402.51377376038, 5659.311826882198, 5465.016297066566, 5524.558035357081, 5527.2538207343105, 5530.281063461724, 5621.919889640859, 5245.265662807134, 5327.147656374961, 5494.313210848644, 5549.306336707911, 5583.413741557078, 5053.823116190915, 5059.584780273374, 5525.668459892419, 5565.55475561946, 5577.832665020056], "value": 4057.542699753709, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.9566825990441, 733.0969361329136, 756.557413912861, 810.8864758933751, 811.5495899775622, 14923.552293431187, 15459.922700386482, 15473.148976806271, 15474.84525154751, 15496.612584685374, 13912.304384780746, 13984.160950342986, 14015.0, 14017.859821401782, 14385.92807035966, 668.4585485756528, 688.6522306235369, 689.3244620272136, 819.4755356571814, 831.4927893984665, 847.9024912135121, 855.3499340501232, 860.7848037990502, 866.5450638414819, 869.1916517638593, 910.2444970674358, 910.7495438754329, 911.9544022798867, 915.5788337364787, 918.3800934369274, 698.0924797762888, 726.4333819620705, 905.9139381758755, 906.4380084347714, 910.8588168833775, 652.8302641313245, 673.1047706550277, 674.2482132422314, 674.9774092250245, 678.3826717686882, 14422.206778627171, 14480.348384322731, 14483.710325793425, 14509.492167774077, 14513.637159071108, 13147.0, 13464.192148471026, 13539.526116585872, 13625.659358516017, 14059.718805623932, 11054.0, 12139.575114870937, 12289.0, 12503.937480312541, 12533.185342952771, 4543.7728113594185, 4556.248219043854, 4563.315502674593, 4576.222042252825, 4620.283856002325, 104537.43193852174, 112063.43968280188, 113198.86801131966, 113295.0, 113821.43089284583, 10558.208134389952, 10743.14054875608, 10854.78290434187, 10863.130949524018, 11052.115830733523, 20999.580008399746, 21015.0, 21353.14587416486, 21392.14431422726, 21401.67897481539, 7673.309402153833, 7752.651130699132, 7772.7668169954995, 7792.454528182972, 7993.760187194393, 4257.6168144867115, 4310.892227694333, 4332.805023773938, 4336.111097225062, 4415.4259946206785, 3381.289929114864, 3490.0402389343135, 3492.777527865227, 3498.038039539147, 3498.5451891253974, 546.9808556700497, 655.924568674599, 662.5395350231543, 662.9171353580803, 663.3731124087691, 549.7004132747662, 550.754914063246, 609.969501524922, 628.4783629587431, 654.1822721598003, 8491.405601607828, 8896.644134234688, 9165.770855728526, 10044.017011309421, 10245.222357569408, 637.9681015949184, 641.493220355923, 650.6649075726004, 692.9168499780059, 701.2881924846286, 4215.430916826251, 4618.445786505641, 5031.7857446054095, 5111.744412779346, 5165.1219292720325, 160212.0, 163555.18222408812, 168020.39847011524, 170196.0, 174303.89936352166, 89086.55456722804, 96135.51932240294, 131340.3432982829, 139542.3022884879, 148032.0, 97586.0, 108093.0, 108389.0, 123538.99837027727, 131252.0, 9392.67125650599, 9545.522723863918, 9592.299882547297, 9837.360176734368, 9838.508074596384, 44810.10379792451, 55181.44818551763, 60457.69771151116, 60988.08517872147, 63617.36382636114, 72736.63631681808, 75752.62123689346, 85872.0, 92271.0, 93791.0, 13252.0, 13376.598702038955, 13399.933000335326, 13517.188968661912, 13642.181469111885, 14890.329935152728, 14993.0, 15055.0, 15062.849371506145, 15366.231688415759, 12338.444769985552, 12675.985921126103, 13869.583912482642, 14067.507637233057, 14095.647608809863, 13302.600921972356, 13608.591742247749, 13791.51729689456, 14265.001449898407, 14279.357428915931, 13133.868661313265, 13251.0, 13398.799018014932, 13456.259905704888, 13709.657258568615, 7917.604119794102, 9070.773230669287, 10164.33931794431, 11143.498542565441, 11807.527698891949, 11175.017274548798, 11187.440627968732, 11401.087912966777, 11404.315741055563, 11452.198346115692], "value": 7787.458799539634, "unit": "score"}], "name": "dromaeo_css", "value": 7452.414549618704, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 114.0, 112.0, 112.0, 114.0, 113.0, 113.0, 112.0, 109.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 114.0, 114.0, 151.0, 116.0, 115.0, 142.0, 143.0, 168.0, 113.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 183.0, 182.0, 186.0, 184.0, 180.0, 181.0, 180.0, 185.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 58.0, 88.0, 60.0, 59.0, 60.0, 58.0, 82.0, 57.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 92.0, 71.0, 68.0, 69.0, 92.0, 67.0, 69.0, 90.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 85.0, 87.0, 84.0, 88.0, 85.0, 89.0, 130.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0, 93.0, 94.0, 93.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 86.0, 86.0, 84.0, 86.0, 85.0, 84.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 54.0, 54.0, 55.0, 53.0, 54.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 71.0, 76.0, 72.0, 68.0, 70.0, 71.0, 71.0, 72.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 88.0, 89.0, 90.0, 85.0, 92.0, 92.0, 108.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 148.0, 153.0, 158.0, 152.0, 156.0, 166.0, 211.0, 159.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 172.0, 172.0, 171.0, 168.0, 185.0, 174.0, 170.0, 172.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 68.0, 68.0, 70.0, 70.0, 69.0, 70.0, 68.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1456.5, "alertThreshold": 2.0}]} 20:03:45 INFO - Return code: 0 20:03:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:03:45 INFO - # TBPL SUCCESS # 20:03:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:03:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:03:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:03:45 INFO - 2016-10-04 20:03:45.242 screenresolution[1956:16682] starting screenresolution argv=screenresolution get 20:03:45 INFO - 2016-10-04 20:03:45.244 screenresolution[1956:16682] Display 0: 1600x1200x32@60 20:03:45 INFO - 2016-10-04 20:03:45.251 screenresolution[1957:16685] starting screenresolution argv=screenresolution list 20:03:45 INFO - Available Modes on Display 0 20:03:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:03:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:03:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:03:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:03:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:03:45 INFO - Intel Iris: 20:03:45 INFO - Chipset Model: Intel Iris 20:03:45 INFO - Type: GPU 20:03:45 INFO - Bus: Built-In 20:03:45 INFO - VRAM (Dynamic, Max): 1536 MB 20:03:45 INFO - Vendor: Intel (0x8086) 20:03:45 INFO - Device ID: 0x0a2e 20:03:45 INFO - Revision ID: 0x0009 20:03:45 INFO - Displays: 20:03:45 INFO - Display: 20:03:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:03:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:03:45 INFO - Display Serial Number: 1600x1200 60 20:03:45 INFO - Main Display: Yes 20:03:45 INFO - Mirror: Off 20:03:45 INFO - Online: Yes 20:03:45 INFO - Rotation: Supported 20:03:45 INFO - Return code: 0 20:03:45 INFO - Running post-action listener: _resource_record_post_action 20:03:45 INFO - [mozharness: 2016-10-05 03:03:45.484929Z] Finished run-tests step (success) 20:03:45 INFO - Running post-run listener: _resource_record_post_run 20:03:45 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 774144; Write bytes: 706681344; Read time: 10; Write time: 2026 20:03:45 INFO - TinderboxPrint: CPU usage
53.5% 20:03:45 INFO - TinderboxPrint: I/O read bytes / time
774,144 / 10 20:03:45 INFO - TinderboxPrint: I/O write bytes / time
706,681,344 / 2,026 20:03:45 INFO - TinderboxPrint: CPU idle
2,254.0 (46.5%) 20:03:45 INFO - TinderboxPrint: CPU system
971.6 (20.0%) 20:03:45 INFO - TinderboxPrint: CPU user
1,624.1 (33.5%) 20:03:45 INFO - TinderboxPrint: Swap in / out
409,243,648 / 0 20:03:45 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404177408; Write bytes: 399255552; Read time: 29996; Write time: 715 20:03:45 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 774144; Write bytes: 294568448; Read time: 10; Write time: 1276 20:03:45 INFO - Running post-run listener: _upload_blobber_files 20:03:45 INFO - Blob upload gear active. 20:03:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:03:45 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 20:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:03:46 INFO - (blobuploader) - INFO - Open directory for files ... 20:03:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:03:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:03:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:47 INFO - (blobuploader) - INFO - Done attempting. 20:03:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:03:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:03:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:48 INFO - (blobuploader) - INFO - Done attempting. 20:03:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:03:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:03:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:03:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:03:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:03:51 INFO - (blobuploader) - INFO - Done attempting. 20:03:51 INFO - (blobuploader) - INFO - Iteration through files over. 20:03:51 INFO - Return code: 0 20:03:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:03:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:03:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d5395fd1f7ef1d1ff9db93bc2d4ff4989a376eb30892ffb672b06bcfdc12f01cc8d8b7ec4aa808c60de2669a6b2474d31b44dbe4d01a0bb8eb028cffd00078d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/673e600bd4bc6f239d060f4294fa36622d07f834103c27b0e7353e818f4d25b4f875277cad5ee3477f9c1febfda321270fecf853b700f1b8305a671fe4d99659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/209929c6d4f1abd71c8867c83f1e439ee3463823534acb76d557ab48eeab92e55e1917502ee93c20b4ec59e61b27a022adb6528284464ba249380a43d1c81d29"} 20:03:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:03:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:03:51 INFO - Contents: 20:03:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d5395fd1f7ef1d1ff9db93bc2d4ff4989a376eb30892ffb672b06bcfdc12f01cc8d8b7ec4aa808c60de2669a6b2474d31b44dbe4d01a0bb8eb028cffd00078d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/673e600bd4bc6f239d060f4294fa36622d07f834103c27b0e7353e818f4d25b4f875277cad5ee3477f9c1febfda321270fecf853b700f1b8305a671fe4d99659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/209929c6d4f1abd71c8867c83f1e439ee3463823534acb76d557ab48eeab92e55e1917502ee93c20b4ec59e61b27a022adb6528284464ba249380a43d1c81d29"} 20:03:51 INFO - Running post-run listener: copy_logs_to_upload_dir 20:03:51 INFO - Copying logs to upload dir... 20:03:51 INFO - mkdir: /builds/slave/test/build/upload/logs 20:03:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.996216 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-04 20:03:51.593133) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 20:03:51.596636) ========= 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.mYoHpRRnkg/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.rCcPgrQadf/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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/Fx-Team/sha512/0d5395fd1f7ef1d1ff9db93bc2d4ff4989a376eb30892ffb672b06bcfdc12f01cc8d8b7ec4aa808c60de2669a6b2474d31b44dbe4d01a0bb8eb028cffd00078d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/673e600bd4bc6f239d060f4294fa36622d07f834103c27b0e7353e818f4d25b4f875277cad5ee3477f9c1febfda321270fecf853b700f1b8305a671fe4d99659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/209929c6d4f1abd71c8867c83f1e439ee3463823534acb76d557ab48eeab92e55e1917502ee93c20b4ec59e61b27a022adb6528284464ba249380a43d1c81d29"} build_url:https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d5395fd1f7ef1d1ff9db93bc2d4ff4989a376eb30892ffb672b06bcfdc12f01cc8d8b7ec4aa808c60de2669a6b2474d31b44dbe4d01a0bb8eb028cffd00078d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/673e600bd4bc6f239d060f4294fa36622d07f834103c27b0e7353e818f4d25b4f875277cad5ee3477f9c1febfda321270fecf853b700f1b8305a671fe4d99659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/209929c6d4f1abd71c8867c83f1e439ee3463823534acb76d557ab48eeab92e55e1917502ee93c20b4ec59e61b27a022adb6528284464ba249380a43d1c81d29"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 20:03:51.629916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 20:03:51.630271) ========= 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.mYoHpRRnkg/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.rCcPgrQadf/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.005198 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 20:03:51.679225) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 20:03:51.679553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 20:03:51.679961) ========= ========= Total master_lag: 0.22 =========