builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0289 starttime: 1477392278.09 results: success (0) buildid: 20161025013209 builduid: 2f1c2d45dd2545f3923b7be78313ef81 revision: 78b863e9fcd9d44d75c817b6495b4585167ba255 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 03:44:38.094414) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 03:44:38.094904) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 03:44:38.095215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 03:44:38.121931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:44:38.122616) ========= 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.OXTPuT8myF/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.h7CwhYlBxE/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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-25 03:44:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 153M=0s 2016-10-25 03:44:38 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150832 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:44:38.296662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:44:38.296997) ========= 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.OXTPuT8myF/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.h7CwhYlBxE/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.024907 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:44:38.346034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 03:44:38.346387) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 78b863e9fcd9d44d75c817b6495b4585167ba255 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 78b863e9fcd9d44d75c817b6495b4585167ba255 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OXTPuT8myF/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.h7CwhYlBxE/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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-25 03:44:38,425 truncating revision to first 12 chars 2016-10-25 03:44:38,425 Setting DEBUG logging. 2016-10-25 03:44:38,425 attempt 1/10 2016-10-25 03:44:38,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/78b863e9fcd9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 03:44:39,609 unpacking tar archive at: mozilla-central-78b863e9fcd9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.447678 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 03:44:39.815663) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 03:44:39.816011) ========= script_repo_revision: 78b863e9fcd9d44d75c817b6495b4585167ba255 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 03:44:39.816417) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 03:44:39.816681) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 03:44:39.834780) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-25 03:44:39.835192) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OXTPuT8myF/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.h7CwhYlBxE/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:44:40 INFO - MultiFileLogger online at 20161025 03:44:40 in /builds/slave/test 03:44:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:44:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:40 INFO - {'append_to_log': False, 03:44:40 INFO - 'base_work_dir': '/builds/slave/test', 03:44:40 INFO - 'blob_upload_branch': 'Firefox', 03:44:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:40 INFO - 'branch': 'Firefox', 03:44:40 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:40 INFO - 'config_files': ('talos/mac_config.py',), 03:44:40 INFO - 'default_actions': ('clobber', 03:44:40 INFO - 'read-buildbot-config', 03:44:40 INFO - 'download-and-extract', 03:44:40 INFO - 'populate-webroot', 03:44:40 INFO - 'create-virtualenv', 03:44:40 INFO - 'install', 03:44:40 INFO - 'run-tests'), 03:44:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:40 INFO - 'download_minidump_stackwalk': True, 03:44:40 INFO - 'download_symbols': 'ondemand', 03:44:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:40 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:40 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:40 INFO - 'installer_path': 'installer.exe', 03:44:40 INFO - 'log_level': 'info', 03:44:40 INFO - 'log_name': 'talos', 03:44:40 INFO - 'log_to_console': True, 03:44:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:44:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:44:40 INFO - 'opt_config_files': (), 03:44:40 INFO - 'pip_index': False, 03:44:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:44:40 INFO - 'cmd': ('bash', 03:44:40 INFO - '-c', 03:44:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:44:40 INFO - 'enabled': True, 03:44:40 INFO - 'halt_on_failure': False, 03:44:40 INFO - 'name': 'check_screen_resolution'},), 03:44:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:44:40 INFO - 'cmd': ('bash', 03:44:40 INFO - '-c', 03:44:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:44:40 INFO - 'enabled': True, 03:44:40 INFO - 'halt_on_failure': False, 03:44:40 INFO - 'name': 'check_screen_resolution'},), 03:44:40 INFO - 'run_cmd_checks_enabled': True, 03:44:40 INFO - 'sps_profile': False, 03:44:40 INFO - 'sps_profile_interval': 0, 03:44:40 INFO - 'suite': 'dromaeojs-e10s', 03:44:40 INFO - 'system_bits': '32', 03:44:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:40 INFO - 'title': 't-yosemite-r7-0289', 03:44:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:40 INFO - 'use_talos_json': True, 03:44:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:40 INFO - 'work_dir': 'build'} 03:44:40 INFO - [mozharness: 2016-10-25 10:44:40.038934Z] Running clobber step. 03:44:40 INFO - Running pre-action listener: _resource_record_pre_action 03:44:40 INFO - Running main action method: clobber 03:44:40 INFO - rmtree: /builds/slave/test/build 03:44:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:42 INFO - Running post-action listener: _resource_record_post_action 03:44:42 INFO - [mozharness: 2016-10-25 10:44:42.280907Z] Finished clobber step (success) 03:44:42 INFO - [mozharness: 2016-10-25 10:44:42.281069Z] Running read-buildbot-config step. 03:44:42 INFO - Running pre-action listener: _resource_record_pre_action 03:44:42 INFO - Running main action method: read_buildbot_config 03:44:42 INFO - Using buildbot properties: 03:44:42 INFO - { 03:44:42 INFO - "project": "", 03:44:42 INFO - "product": "firefox", 03:44:42 INFO - "script_repo_revision": "production", 03:44:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:44:42 INFO - "repository": "", 03:44:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:44:42 INFO - "buildid": "20161025013209", 03:44:42 INFO - "pgo_build": "False", 03:44:42 INFO - "basedir": "/builds/slave/test", 03:44:42 INFO - "buildnumber": 79, 03:44:42 INFO - "slavename": "t-yosemite-r7-0289", 03:44:42 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:44:42 INFO - "platform": "yosemite_r7", 03:44:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:44:42 INFO - "branch": "mozilla-central", 03:44:42 INFO - "repo_path": "mozilla-central", 03:44:42 INFO - "revision": "78b863e9fcd9d44d75c817b6495b4585167ba255", 03:44:42 INFO - "stage_platform": "macosx64", 03:44:42 INFO - "builduid": "2f1c2d45dd2545f3923b7be78313ef81", 03:44:42 INFO - "slavebuilddir": "test" 03:44:42 INFO - } 03:44:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 03:44:42 INFO - Running post-action listener: _resource_record_post_action 03:44:42 INFO - [mozharness: 2016-10-25 10:44:42.284378Z] Finished read-buildbot-config step (success) 03:44:42 INFO - [mozharness: 2016-10-25 10:44:42.284499Z] Running download-and-extract step. 03:44:42 INFO - Running pre-action listener: _resource_record_pre_action 03:44:42 INFO - Running main action method: download_and_extract 03:44:42 INFO - mkdir: /builds/slave/test/build/tests 03:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:42 INFO - trying https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 03:44:42 INFO - Downloading https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/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 03:44:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/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 03:44:43 INFO - Downloaded 1199 bytes. 03:44:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:44:43 INFO - Using the following test package requirements: 03:44:43 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:44:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 03:44:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 03:44:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:44:43 INFO - u'jsshell-mac.zip'], 03:44:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 03:44:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:44:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 03:44:43 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 03:44:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 03:44:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:44:43 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 03:44:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:44:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:44:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:44:43 INFO - Fetch https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:44:44 INFO - Http code: 200 03:44:44 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 03:44:44 INFO - x-amz-cf-id: slA_YQY2fk2dqKmRgfV2M-7HgPF0lEapHCr5bqvS2AxAD8K6GmIsNg== 03:44:44 INFO - x-amz-version-id: X7bashdUr5N4TS6_kPpIU7tw6ouq9r_w 03:44:44 INFO - Expected file size: 16423608 03:44:44 INFO - Obtained file size: 16423608 03:44:51 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 03:44:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:44:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:44:51 INFO - Fetch https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:44:51 INFO - Http code: 200 03:44:51 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 03:44:51 INFO - x-amz-cf-id: trg5_xNUiZ1FpzGszu7AJSxTs7US0SrXYkYwqEuPhGhFEnHopvQksA== 03:44:51 INFO - x-amz-version-id: X7bashdUr5N4TS6_kPpIU7tw6ouq9r_w 03:44:52 INFO - Expected file size: 16423608 03:44:52 INFO - Obtained file size: 16423608 03:44:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 03:44:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:44:58 INFO - Fetch https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 03:44:59 INFO - Http code: 200 03:44:59 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 03:44:59 INFO - x-amz-cf-id: zhKUb0JQZvL2OS3LOO9ek059j8AIDYQZWaJ3pAHvEwvME-XNjYhEgQ== 03:44:59 INFO - x-amz-version-id: dq4aBjwhgYn7SrOWOiMIx0Lj512aVPG6 03:44:59 INFO - Expected file size: 14409028 03:44:59 INFO - Obtained file size: 14409028 03:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:00 INFO - trying https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:45:00 INFO - Downloading https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 03:45:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/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 03:45:02 INFO - Downloaded 111300840 bytes. 03:45:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:45:02 INFO - mkdir: /builds/slave/test/properties 03:45:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:45:02 INFO - Writing to file /builds/slave/test/properties/build_url 03:45:02 INFO - Contents: 03:45:02 INFO - build_url:https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:45:03 INFO - Running post-action listener: _resource_record_post_action 03:45:03 INFO - Running post-action listener: set_extra_try_arguments 03:45:03 INFO - [mozharness: 2016-10-25 10:45:03.874161Z] Finished download-and-extract step (success) 03:45:03 INFO - [mozharness: 2016-10-25 10:45:03.874317Z] Running populate-webroot step. 03:45:03 INFO - Running pre-action listener: _resource_record_pre_action 03:45:03 INFO - Running main action method: populate_webroot 03:45:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:45:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:45:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:45:03 INFO - '--tppagecycles', 03:45:03 INFO - '7'], 03:45:03 INFO - 'tests': ['tsvgm']}}, 03:45:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:45:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:45:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:45:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:45:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:45:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:45:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:03 INFO - 'talos_options': ['--disable-e10s'], 03:45:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:03 INFO - 'talos_options': ['--disable-e10s'], 03:45:03 INFO - 'tests': ['damp', 'tps']}, 03:45:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:03 INFO - 'tests': ['damp', 'tps']}, 03:45:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:45:03 INFO - 'tests': ['dromaeo_dom']}, 03:45:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:45:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:45:03 INFO - 'tests': ['basic_compositor_video']}, 03:45:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:45:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:45:03 INFO - 'tests': ['a11yr', 03:45:03 INFO - 'ts_paint', 03:45:03 INFO - 'tpaint', 03:45:03 INFO - 'sessionrestore', 03:45:03 INFO - 'sessionrestore_no_auto_restore', 03:45:03 INFO - 'tabpaint']}, 03:45:03 INFO - 'other-e10s': {'tests': ['a11yr', 03:45:03 INFO - 'ts_paint', 03:45:03 INFO - 'tpaint', 03:45:03 INFO - 'sessionrestore', 03:45:03 INFO - 'sessionrestore_no_auto_restore', 03:45:03 INFO - 'tabpaint']}, 03:45:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:45:03 INFO - 'ts_paint', 03:45:03 INFO - 'tpaint', 03:45:03 INFO - 'sessionrestore', 03:45:03 INFO - 'sessionrestore_no_auto_restore', 03:45:03 INFO - 'tabpaint']}, 03:45:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:45:03 INFO - 'ts_paint', 03:45:03 INFO - 'tpaint', 03:45:03 INFO - 'sessionrestore', 03:45:03 INFO - 'sessionrestore_no_auto_restore', 03:45:03 INFO - 'tabpaint']}, 03:45:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:45:03 INFO - 'tests': ['a11yr', 03:45:03 INFO - 'ts_paint', 03:45:03 INFO - 'tpaint', 03:45:03 INFO - 'sessionrestore', 03:45:03 INFO - 'sessionrestore_no_auto_restore', 03:45:03 INFO - 'tabpaint']}, 03:45:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:45:03 INFO - 'tests': ['a11yr', 03:45:03 INFO - 'ts_paint', 03:45:03 INFO - 'tpaint', 03:45:03 INFO - 'sessionrestore', 03:45:03 INFO - 'sessionrestore_no_auto_restore', 03:45:03 INFO - 'tabpaint']}, 03:45:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:45:03 INFO - 'tests': ['tsvgx', 03:45:03 INFO - 'tsvgr_opacity', 03:45:03 INFO - 'tart', 03:45:03 INFO - 'tscrollx', 03:45:03 INFO - 'cart']}, 03:45:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:45:03 INFO - 'tsvgr_opacity', 03:45:03 INFO - 'tart', 03:45:03 INFO - 'tscrollx', 03:45:03 INFO - 'cart']}, 03:45:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:03 INFO - 'talos_options': ['--disable-e10s'], 03:45:03 INFO - 'tests': ['tp5o']}, 03:45:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:03 INFO - 'tests': ['tp5o']}, 03:45:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:03 INFO - 'talos_options': ['--disable-e10s', 03:45:03 INFO - '--xperf_path', 03:45:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:03 INFO - 'tests': ['tp5n']}, 03:45:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:03 INFO - 'talos_options': ['--xperf_path', 03:45:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:03 INFO - 'tests': ['tp5n']}}, 03:45:03 INFO - 'talos.zip': {'path': '', 03:45:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:45:03 INFO - Running post-action listener: _resource_record_post_action 03:45:03 INFO - [mozharness: 2016-10-25 10:45:03.893046Z] Finished populate-webroot step (success) 03:45:03 INFO - [mozharness: 2016-10-25 10:45:03.893179Z] Running create-virtualenv step. 03:45:03 INFO - Running pre-action listener: _resource_record_pre_action 03:45:03 INFO - Running main action method: create_virtualenv 03:45:03 INFO - Creating virtualenv /builds/slave/test/build/venv 03:45:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:45:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:45:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:45:04 INFO - Using real prefix '/tools/python27' 03:45:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:45:04 INFO - Installing distribute.............................................................................................................................................................................................done. 03:45:07 INFO - Installing pip.................done. 03:45:07 INFO - Return code: 0 03:45:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:45:07 INFO - Reading from file tmpfile_stdout 03:45:07 INFO - Output received: 03:45:07 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:45:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:07 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 0x105ec1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e37570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8c75c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd5d30>, '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 0x105afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ccdb20>, '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.OXTPuT8myF/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.h7CwhYlBxE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:45:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OXTPuT8myF/Render', 03:45:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:07 INFO - 'HOME': '/Users/cltbld', 03:45:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:07 INFO - 'LOGNAME': 'cltbld', 03:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:07 INFO - 'MOZ_NO_REMOTE': '1', 03:45:07 INFO - 'NO_EM_RESTART': '1', 03:45:07 INFO - 'PAGER': '/bin/cat', 03:45:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:07 INFO - 'PWD': '/builds/slave/test', 03:45:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:07 INFO - 'SHELL': '/bin/bash', 03:45:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7CwhYlBxE/Listeners', 03:45:07 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:45:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:07 INFO - 'USER': 'cltbld', 03:45:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:07 INFO - 'XPC_FLAGS': '0x0', 03:45:07 INFO - 'XPC_SERVICE_NAME': '0', 03:45:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:45:08 INFO - Cleaning up... 03:45:08 INFO - Return code: 0 03:45:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:08 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 0x105ec1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e37570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8c75c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd5d30>, '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 0x105afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ccdb20>, '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.OXTPuT8myF/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.h7CwhYlBxE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:45:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OXTPuT8myF/Render', 03:45:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:08 INFO - 'HOME': '/Users/cltbld', 03:45:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:08 INFO - 'LOGNAME': 'cltbld', 03:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:08 INFO - 'MOZ_NO_REMOTE': '1', 03:45:08 INFO - 'NO_EM_RESTART': '1', 03:45:08 INFO - 'PAGER': '/bin/cat', 03:45:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:08 INFO - 'PWD': '/builds/slave/test', 03:45:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:08 INFO - 'SHELL': '/bin/bash', 03:45:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7CwhYlBxE/Listeners', 03:45:08 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:45:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:08 INFO - 'USER': 'cltbld', 03:45:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:08 INFO - 'XPC_FLAGS': '0x0', 03:45:08 INFO - 'XPC_SERVICE_NAME': '0', 03:45:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:08 INFO - Downloading/unpacking psutil>=3.1.1 03:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:45:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:11 INFO - Installing collected packages: psutil 03:45:11 INFO - Running setup.py install for psutil 03:45:11 INFO - building 'psutil._psutil_osx' extension 03:45:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:45:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:45:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:45:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:45:12 INFO - building 'psutil._psutil_posix' extension 03:45:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:45:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:45:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:45:12 INFO - ^ 03:45:12 INFO - 1 warning generated. 03:45:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:45:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:12 INFO - Successfully installed psutil 03:45:12 INFO - Cleaning up... 03:45:13 INFO - Return code: 0 03:45:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:45: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')]} 03:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45: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')]} 03:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ec1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e37570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8c75c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd5d30>, '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 0x105afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ccdb20>, '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.OXTPuT8myF/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.h7CwhYlBxE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:45: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:45: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 mozsystemmonitor==0.3 03:45:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OXTPuT8myF/Render', 03:45:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:13 INFO - 'HOME': '/Users/cltbld', 03:45:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:13 INFO - 'LOGNAME': 'cltbld', 03:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:13 INFO - 'MOZ_NO_REMOTE': '1', 03:45:13 INFO - 'NO_EM_RESTART': '1', 03:45:13 INFO - 'PAGER': '/bin/cat', 03:45:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:13 INFO - 'PWD': '/builds/slave/test', 03:45:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:13 INFO - 'SHELL': '/bin/bash', 03:45:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7CwhYlBxE/Listeners', 03:45:13 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:45:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:13 INFO - 'USER': 'cltbld', 03:45:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:13 INFO - 'XPC_FLAGS': '0x0', 03:45:13 INFO - 'XPC_SERVICE_NAME': '0', 03:45:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:45: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 03:45: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 03:45: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 03:45: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 03:45: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 03:45: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 03:45:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:45:15 INFO - Installing collected packages: mozsystemmonitor 03:45:15 INFO - Running setup.py install for mozsystemmonitor 03:45:15 INFO - Successfully installed mozsystemmonitor 03:45:15 INFO - Cleaning up... 03:45:16 INFO - Return code: 0 03:45:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ec1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e37570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8c75c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd5d30>, '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 0x105afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ccdb20>, '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.OXTPuT8myF/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.h7CwhYlBxE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:45:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:45:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OXTPuT8myF/Render', 03:45:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:16 INFO - 'HOME': '/Users/cltbld', 03:45:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:16 INFO - 'LOGNAME': 'cltbld', 03:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:16 INFO - 'MOZ_NO_REMOTE': '1', 03:45:16 INFO - 'NO_EM_RESTART': '1', 03:45:16 INFO - 'PAGER': '/bin/cat', 03:45:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:16 INFO - 'PWD': '/builds/slave/test', 03:45:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:16 INFO - 'SHELL': '/bin/bash', 03:45:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7CwhYlBxE/Listeners', 03:45:16 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:45:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:16 INFO - 'USER': 'cltbld', 03:45:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:16 INFO - 'XPC_FLAGS': '0x0', 03:45:16 INFO - 'XPC_SERVICE_NAME': '0', 03:45:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:16 INFO - Downloading/unpacking jsonschema==2.5.1 03:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:45:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:19 INFO - Downloading functools32-3.2.3-2.tar.gz 03:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:45:19 INFO - warning: no files found matching '*.txt' 03:45:19 INFO - no previously-included directories found matching 'build' 03:45:19 INFO - no previously-included directories found matching 'dist' 03:45:19 INFO - no previously-included directories found matching '.git*' 03:45:19 INFO - Installing collected packages: jsonschema, functools32 03:45:19 INFO - Running setup.py install for functools32 03:45:19 INFO - warning: no files found matching '*.txt' 03:45:19 INFO - no previously-included directories found matching 'build' 03:45:19 INFO - no previously-included directories found matching 'dist' 03:45:19 INFO - no previously-included directories found matching '.git*' 03:45:19 INFO - Successfully installed jsonschema functools32 03:45:19 INFO - Cleaning up... 03:45:19 INFO - Return code: 0 03:45:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:19 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 0x105ec1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e37570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8c75c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd5d30>, '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 0x105afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ccdb20>, '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.OXTPuT8myF/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.h7CwhYlBxE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:45:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OXTPuT8myF/Render', 03:45:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:19 INFO - 'HOME': '/Users/cltbld', 03:45:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:19 INFO - 'LOGNAME': 'cltbld', 03:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:19 INFO - 'MOZ_NO_REMOTE': '1', 03:45:19 INFO - 'NO_EM_RESTART': '1', 03:45:19 INFO - 'PAGER': '/bin/cat', 03:45:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:19 INFO - 'PWD': '/builds/slave/test', 03:45:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:19 INFO - 'SHELL': '/bin/bash', 03:45:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7CwhYlBxE/Listeners', 03:45:19 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:45:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:19 INFO - 'USER': 'cltbld', 03:45:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:19 INFO - 'XPC_FLAGS': '0x0', 03:45:19 INFO - 'XPC_SERVICE_NAME': '0', 03:45:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:45:19 INFO - Cleaning up... 03:45:19 INFO - Return code: 0 03:45:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:19 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 0x105ec1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e37570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8c75c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd5d30>, '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 0x105afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ccdb20>, '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.OXTPuT8myF/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.h7CwhYlBxE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:45:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OXTPuT8myF/Render', 03:45:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:19 INFO - 'HOME': '/Users/cltbld', 03:45:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:19 INFO - 'LOGNAME': 'cltbld', 03:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:19 INFO - 'MOZ_NO_REMOTE': '1', 03:45:19 INFO - 'NO_EM_RESTART': '1', 03:45:19 INFO - 'PAGER': '/bin/cat', 03:45:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:19 INFO - 'PWD': '/builds/slave/test', 03:45:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:19 INFO - 'SHELL': '/bin/bash', 03:45:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7CwhYlBxE/Listeners', 03:45:19 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:45:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:19 INFO - 'USER': 'cltbld', 03:45:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:19 INFO - 'XPC_FLAGS': '0x0', 03:45:19 INFO - 'XPC_SERVICE_NAME': '0', 03:45:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:20 INFO - Downloading/unpacking blobuploader==1.2.4 03:45: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 03:45: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 03:45: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 03:45: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 03:45: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 03:45: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 03:45:22 INFO - Downloading blobuploader-1.2.4.tar.gz 03:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:45:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:45:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:23 INFO - Downloading docopt-0.6.1.tar.gz 03:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:45:23 INFO - Installing collected packages: blobuploader, requests, docopt 03:45:23 INFO - Running setup.py install for blobuploader 03:45:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:45:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:45:24 INFO - Running setup.py install for requests 03:45:24 INFO - Running setup.py install for docopt 03:45:24 INFO - Successfully installed blobuploader requests docopt 03:45:24 INFO - Cleaning up... 03:45:24 INFO - Return code: 0 03:45:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:24 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 0x105ec1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e37570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8c75c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd5d30>, '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 0x105afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ccdb20>, '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.OXTPuT8myF/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.h7CwhYlBxE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:45:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:45:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:45:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OXTPuT8myF/Render', 03:45:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:24 INFO - 'HOME': '/Users/cltbld', 03:45:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:24 INFO - 'LOGNAME': 'cltbld', 03:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:24 INFO - 'MOZ_NO_REMOTE': '1', 03:45:24 INFO - 'NO_EM_RESTART': '1', 03:45:24 INFO - 'PAGER': '/bin/cat', 03:45:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:24 INFO - 'PWD': '/builds/slave/test', 03:45:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:24 INFO - 'SHELL': '/bin/bash', 03:45:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7CwhYlBxE/Listeners', 03:45:24 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:45:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:24 INFO - 'USER': 'cltbld', 03:45:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:24 INFO - 'XPC_FLAGS': '0x0', 03:45:24 INFO - 'XPC_SERVICE_NAME': '0', 03:45:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:24 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-KAJckq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-URJh7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-jSadBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-KBFQ4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-QmXMMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-_6TZ8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-vqyIUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-1uWLud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-RUw942-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:25 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ME4V7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:26 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-LoUH1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:26 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-kyBbkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:26 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-3j8TEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:26 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-MdYiaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:26 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-mha78W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:26 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-fB3zDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:26 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-YQygmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:45:26 INFO - Running setup.py install for manifestparser 03:45:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:45:26 INFO - Running setup.py install for mozcrash 03:45:27 INFO - Running setup.py install for mozdebug 03:45:27 INFO - Running setup.py install for mozdevice 03:45:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:45:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:45:27 INFO - Running setup.py install for mozfile 03:45:27 INFO - Running setup.py install for mozhttpd 03:45:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:45:27 INFO - Running setup.py install for mozinfo 03:45:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:45:27 INFO - Running setup.py install for mozInstall 03:45:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:45:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:45:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:45:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:45:27 INFO - Running setup.py install for mozleak 03:45:28 INFO - Running setup.py install for mozlog 03:45:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:45:28 INFO - Running setup.py install for moznetwork 03:45:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:45:28 INFO - Running setup.py install for mozprocess 03:45:28 INFO - Running setup.py install for mozprofile 03:45:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:45:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:45:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:45:28 INFO - Running setup.py install for mozrunner 03:45:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:45:28 INFO - Running setup.py install for mozscreenshot 03:45:29 INFO - Running setup.py install for moztest 03:45:29 INFO - Running setup.py install for mozversion 03:45:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:45:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:45:29 INFO - Cleaning up... 03:45:29 INFO - Return code: 0 03:45:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:29 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 0x105ec1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e37570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8c75c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd5d30>, '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 0x105afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ccdb20>, '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.OXTPuT8myF/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.h7CwhYlBxE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OXTPuT8myF/Render', 03:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:29 INFO - 'HOME': '/Users/cltbld', 03:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:29 INFO - 'LOGNAME': 'cltbld', 03:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:29 INFO - 'MOZ_NO_REMOTE': '1', 03:45:29 INFO - 'NO_EM_RESTART': '1', 03:45:29 INFO - 'PAGER': '/bin/cat', 03:45:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:29 INFO - 'PWD': '/builds/slave/test', 03:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:29 INFO - 'SHELL': '/bin/bash', 03:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7CwhYlBxE/Listeners', 03:45:29 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:29 INFO - 'USER': 'cltbld', 03:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:29 INFO - 'XPC_FLAGS': '0x0', 03:45:29 INFO - 'XPC_SERVICE_NAME': '0', 03:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-BuPTyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-yxf6AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:29 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)) 03:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-8PZuWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:29 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-M8hreH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:30 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)) 03:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-5bmdKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-jV2yak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-tdmnYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-rnwHFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-68W74L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-SEdTix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-wtG24p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-5K2vo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:30 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)) 03:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-NTNeQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:30 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-JdFgAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:31 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)) 03:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:31 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-E57hBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:31 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-1zpjdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:31 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)) 03:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:31 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-6D1iLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:45:31 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)) 03:45:31 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)) 03:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:45:31 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)) 03:45:31 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)) 03:45:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:33 INFO - Downloading blessings-1.6.tar.gz 03:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:45:34 INFO - Installing collected packages: blessings 03:45:34 INFO - Running setup.py install for blessings 03:45:34 INFO - Successfully installed blessings 03:45:34 INFO - Cleaning up... 03:45:34 INFO - Return code: 0 03:45:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:34 INFO - Reading from file tmpfile_stdout 03:45:34 INFO - Current package versions: 03:45:34 INFO - blessings == 1.6 03:45:34 INFO - blobuploader == 1.2.4 03:45:34 INFO - docopt == 0.6.1 03:45:34 INFO - functools32 == 3.2.3-2 03:45:34 INFO - jsonschema == 2.5.1 03:45:34 INFO - manifestparser == 1.1 03:45:34 INFO - mozInstall == 1.12 03:45:34 INFO - mozcrash == 0.17 03:45:34 INFO - mozdebug == 0.1 03:45:34 INFO - mozdevice == 0.48 03:45:34 INFO - mozfile == 1.2 03:45:34 INFO - mozhttpd == 0.7 03:45:34 INFO - mozinfo == 0.9 03:45:34 INFO - mozleak == 0.1 03:45:34 INFO - mozlog == 3.4 03:45:34 INFO - moznetwork == 0.27 03:45:34 INFO - mozprocess == 0.23 03:45:34 INFO - mozprofile == 0.28 03:45:34 INFO - mozrunner == 6.12 03:45:34 INFO - mozscreenshot == 0.1 03:45:34 INFO - mozsystemmonitor == 0.3 03:45:34 INFO - moztest == 0.7 03:45:34 INFO - mozversion == 1.4 03:45:34 INFO - psutil == 3.1.1 03:45:34 INFO - requests == 1.2.3 03:45:34 INFO - wsgiref == 0.1.2 03:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:34 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 0x105ec1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e37570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8c75c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd5d30>, '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 0x105afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ccdb20>, '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.OXTPuT8myF/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.h7CwhYlBxE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OXTPuT8myF/Render', 03:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:34 INFO - 'HOME': '/Users/cltbld', 03:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:34 INFO - 'LOGNAME': 'cltbld', 03:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:34 INFO - 'MOZ_NO_REMOTE': '1', 03:45:34 INFO - 'NO_EM_RESTART': '1', 03:45:34 INFO - 'PAGER': '/bin/cat', 03:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:34 INFO - 'PWD': '/builds/slave/test', 03:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:34 INFO - 'SHELL': '/bin/bash', 03:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7CwhYlBxE/Listeners', 03:45:34 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:34 INFO - 'USER': 'cltbld', 03:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:34 INFO - 'XPC_FLAGS': '0x0', 03:45:34 INFO - 'XPC_SERVICE_NAME': '0', 03:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:45:34 INFO - Cleaning up... 03:45:34 INFO - Return code: 0 03:45:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:35 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 0x105ec1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e37570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b8c75c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cd5d30>, '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 0x105afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ccdb20>, '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.OXTPuT8myF/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.h7CwhYlBxE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:45:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OXTPuT8myF/Render', 03:45:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:35 INFO - 'HOME': '/Users/cltbld', 03:45:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:35 INFO - 'LOGNAME': 'cltbld', 03:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:35 INFO - 'MOZ_NO_REMOTE': '1', 03:45:35 INFO - 'NO_EM_RESTART': '1', 03:45:35 INFO - 'PAGER': '/bin/cat', 03:45:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:35 INFO - 'PWD': '/builds/slave/test', 03:45:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:35 INFO - 'SHELL': '/bin/bash', 03:45:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7CwhYlBxE/Listeners', 03:45:35 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:45:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:35 INFO - 'USER': 'cltbld', 03:45:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:35 INFO - 'XPC_FLAGS': '0x0', 03:45:35 INFO - 'XPC_SERVICE_NAME': '0', 03:45:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:45:36 INFO - Cleaning up... 03:45:36 INFO - Return code: 0 03:45:36 INFO - Running post-action listener: _resource_record_post_action 03:45:36 INFO - Running post-action listener: _start_resource_monitoring 03:45:36 INFO - Starting resource monitoring. 03:45:36 INFO - [mozharness: 2016-10-25 10:45:36.283962Z] Finished create-virtualenv step (success) 03:45:36 INFO - [mozharness: 2016-10-25 10:45:36.284970Z] Running install step. 03:45:36 INFO - Running pre-action listener: _resource_record_pre_action 03:45:36 INFO - Running main action method: install 03:45:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:36 INFO - Reading from file tmpfile_stdout 03:45:36 INFO - Detecting whether we're running mozinstall >=1.0... 03:45:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:45:36 INFO - Reading from file tmpfile_stdout 03:45:36 INFO - Output received: 03:45:36 INFO - Usage: mozinstall [options] installer 03:45:36 INFO - Options: 03:45:36 INFO - -h, --help show this help message and exit 03:45:36 INFO - -d DEST, --destination=DEST 03:45:36 INFO - Directory to install application into. [default: 03:45:36 INFO - "/builds/slave/test"] 03:45:36 INFO - --app=APP Application being installed. [default: firefox] 03:45:36 INFO - mkdir: /builds/slave/test/build/application 03:45:36 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'] 03:45:36 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 03:46:11 INFO - Reading from file tmpfile_stdout 03:46:11 INFO - Output received: 03:46:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:46:11 INFO - Running post-action listener: _resource_record_post_action 03:46:11 INFO - [mozharness: 2016-10-25 10:46:11.726354Z] Finished install step (success) 03:46:11 INFO - [mozharness: 2016-10-25 10:46:11.726522Z] Running run-tests step. 03:46:11 INFO - Running pre-action listener: _resource_record_pre_action 03:46:11 INFO - Running main action method: run_tests 03:46:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:46:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:46:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:46:11 INFO - 2016-10-25 03:46:11.741 screenresolution[1639:7584] starting screenresolution argv=screenresolution get 03:46:11 INFO - 2016-10-25 03:46:11.744 screenresolution[1639:7584] Display 0: 1600x1200x32@60 03:46:11 INFO - 2016-10-25 03:46:11.749 screenresolution[1640:7586] starting screenresolution argv=screenresolution list 03:46:11 INFO - Available Modes on Display 0 03:46:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:46:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:46:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:46:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:46:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:46:11 INFO - Intel Iris: 03:46:11 INFO - Chipset Model: Intel Iris 03:46:11 INFO - Type: GPU 03:46:11 INFO - Bus: Built-In 03:46:11 INFO - VRAM (Dynamic, Max): 1536 MB 03:46:11 INFO - Vendor: Intel (0x8086) 03:46:11 INFO - Device ID: 0x0a2e 03:46:11 INFO - Revision ID: 0x0009 03:46:11 INFO - Displays: 03:46:11 INFO - Display: 03:46:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:46:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:46:11 INFO - Display Serial Number: 1600x1200 60 03:46:11 INFO - Main Display: Yes 03:46:11 INFO - Mirror: Off 03:46:11 INFO - Online: Yes 03:46:11 INFO - Rotation: Supported 03:46:11 INFO - Return code: 0 03:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:46:11 INFO - Python 2.7.3 03:46:11 INFO - Return code: 0 03:46:11 INFO - grabbing minidump binary from tooltool 03:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:11 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 0x105cd5d30>, '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 0x105afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ccdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:46:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:46:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:46:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:46:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:46:12 INFO - Return code: 0 03:46:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:46:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:46:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:46:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:46:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:46:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0289 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:46:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OXTPuT8myF/Render', 03:46:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:46:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:46:12 INFO - 'HOME': '/Users/cltbld', 03:46:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:46:12 INFO - 'LOGNAME': 'cltbld', 03:46:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:46:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:12 INFO - 'MOZ_NO_REMOTE': '1', 03:46:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:46:12 INFO - 'NO_EM_RESTART': '1', 03:46:12 INFO - 'PAGER': '/bin/cat', 03:46:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:12 INFO - 'PWD': '/builds/slave/test', 03:46:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:46:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:46:12 INFO - 'SHELL': '/bin/bash', 03:46:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h7CwhYlBxE/Listeners', 03:46:12 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 03:46:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:46:12 INFO - 'USER': 'cltbld', 03:46:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:46:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:12 INFO - 'XPC_FLAGS': '0x0', 03:46:12 INFO - 'XPC_SERVICE_NAME': '0', 03:46:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:46:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:46:12 INFO - mozversion application_buildid: 20161025013209 03:46:12 INFO - mozversion application_changeset: 78b863e9fcd9d44d75c817b6495b4585167ba255 03:46:12 INFO - mozversion application_display_name: Nightly 03:46:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:46:12 INFO - mozversion application_name: Firefox 03:46:12 INFO - mozversion application_remotingname: firefox 03:46:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:46:12 INFO - mozversion application_vendor: Mozilla 03:46:12 INFO - mozversion application_version: 52.0a1 03:46:12 INFO - mozversion platform_buildid: 20161025013209 03:46:12 INFO - mozversion platform_changeset: 78b863e9fcd9d44d75c817b6495b4585167ba255 03:46:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:46:12 INFO - mozversion platform_version: 52.0a1 03:46:12 INFO - using testdate: 1477392372 03:46:12 INFO - actual date: 1477392372 03:46:12 INFO - starting webserver on 'localhost:49273' 03:46:12 INFO - SUITE-START | Running 2 tests 03:46:12 INFO - TEST-START | dromaeo_css 03:46:12 INFO - operating with platform_type : mac_ 03:46:12 INFO - Initialising browser for dromaeo_css test... 03:46:12 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmp0t0sqA/profile http://localhost:49273/getInfo.html) 03:46:15 INFO - PROCESS | 1650 | 2016-10-25 03:46:15.184 plugin-container[1652:7758] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3b, name = 'com.apple.tsm.portname' 03:46:15 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:46:15 INFO - PROCESS | 1650 | 2016-10-25 03:46:15.187 plugin-container[1652:7758] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b17, name = 'com.apple.CFPasteboardClient' 03:46:15 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:46:15 INFO - PROCESS | 1650 | 2016-10-25 03:46:15.187 plugin-container[1652:7758] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:46:15 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 03:46:15 INFO - PROCESS | 1650 | colorDepth:24 03:46:15 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 03:46:15 INFO - PROCESS | 1650 | __metrics 03:46:15 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 03:46:16 INFO - TEST-INFO | 1650: exit 0 03:46:16 INFO - Browser initialized. 03:46:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:46:16 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmp0t0sqA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:18 INFO - PROCESS | 1653 | 2016-10-25 03:46:18.518 plugin-container[1654:7877] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 03:46:18 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:46:18 INFO - PROCESS | 1653 | 2016-10-25 03:46:18.518 plugin-container[1654:7877] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 03:46:18 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:46:18 INFO - PROCESS | 1653 | 2016-10-25 03:46:18.518 plugin-container[1654:7877] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:46:28 INFO - PROCESS | 1653 | RSS: Main: 235905024 03:46:28 INFO - PROCESS | 1653 | 03:47:17 INFO - PROCESS | 1653 | 1477392437729 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] 03:49:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 03:49:32 INFO - PROCESS | 1653 | RSS: Main: 250593280 03:49:32 INFO - PROCESS | 1653 | 03:52:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 03:52:35 INFO - PROCESS | 1653 | RSS: Main: 262029312 03:52:35 INFO - PROCESS | 1653 | 03:55:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 03:55:37 INFO - PROCESS | 1653 | RSS: Main: 267792384 03:55:37 INFO - PROCESS | 1653 | 03:58:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 03:58:40 INFO - PROCESS | 1653 | RSS: Main: 268804096 03:58:40 INFO - PROCESS | 1653 | 04:01:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 04:01:43 INFO - PROCESS | 1653 | RSS: Main: 274305024 04:01:43 INFO - PROCESS | 1653 | 04:04:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 04:04:46 INFO - PROCESS | 1653 | RSS: Main: 277086208 04:04:46 INFO - PROCESS | 1653 | 04:04:46 INFO - PROCESS | 1653 | __start_tp_report 04:04:46 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 04:04:46 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 04:04:46 INFO - PROCESS | 1653 | |i|pagename|runs| 04:04:46 INFO - PROCESS | 1653 | |0;dojo.html;3350.313185796909;3363.344147891161;3387.102417859268;3392.5759280089974;3403.9829800850994;5535.723213839312;5591.356993945703;5608.635438696482;5635.802746903859;5661.2923384576925;5600.991821472134;5619.915701264485;5668.093105103184;5690.800821971222;5733.340665823432;4603.987122832971;4626.958934239786;4756.453007904083;5111.309973153632;5299.894002119955;5045.142325804622;5244.475552444744;5270.7628156733035;5274.918641678447;5281.155015197569;5091.516305950929;5126.71803050832;5132.024915266087;5169.2504586835075;5239.659422137549;5160.690358578498;5216.747980484656;5221.947780522184;5222.3472065991755;5265.0259701955265;4233.915321693579;4261.808218630169;5129.717865517395;5154.201098829687;5160.25176349431;4400.713953593006;4929.6795708279205;5483.2049352844015;5528.474794894479;5536.750846211889;6093.421124993119;6125.448709616156;6153.446189842935;6192.87614247717;6193.318734939153;6150.600210986271;6160.8767824643255;6171.197744293213;6210.875782484325;6243.8126856194385;5646.181303710939;5774.797882074149;5779.422057794271;5784.305883294031;5816.098504731731;5309.230161626542;6166.506679465632;6185.752569897244;6192.318844927055;6196.8760624787255;6039.818805435844;6106.938930610637;6115.785947491817;6118.847028824315;6126.78556250538;5375.220593013991;6013.338532761392;6206.10011548332;6216.658083805343;6239.0953311770445;6067.332593414721;6102.603330783485;6138.355472675305;6142.928535732134;6147.415995480422;6160.568760186834;6161.84595385119;6173;6194.287656919512;6229.0967809667345;4916;4917.164082106051;4921;4922.261660750844;4928.236123400879;4334.436523251957;4341.848035318749;4345.500267469219;4347.456567929009;4456.5766252205985;4668.369770080995;5764.538836893039;5783.566232532493;5822.475977162076;5838.2702162229725;6110.083487476825;6198.6280823149855;6224.62652240867;6229;6240.625562466175;5647.152927060892;5676.574256930747;5788.681622510802;5790.7973220937065;5818.127280907813;5309.734513274321;5325.840224793263;5358.356997160366;5385.8114965976;5425.864353391197;6301;6304.621722696653;6312;6317.96841015792;6335.493160547145;6063.211782468427;6208.81373558794;6211;6224.439800417984;6225.439710425902;6172.043333283348;6176.536759742948;6192.164057852132;6212.254529456494;6230.813075607739;6149;6150.50795936333;6155.446009859134;6187.195664563578;6203.4416902479;6165.136880836776;6177.752889884354;6179.28938172098;6193.38066193377;6196.256449226122;3791.279656865187;5248.186531087687;5886.470217680429;6016.789412370546;6050.394960503914;5967.283925928743;6044.425779550936;6059.3334733178435;6088.634681919099;6110.602810817282;5779.393163717749;5825.330087040044;5867.061270196748;5870.853228669317;5931.851703707269;6096.878062438637;6112.602680825732;6112.74665817949;6113.877722445437;6121.296050954019;5913.91129133072;5914.674692891932;5917.408259174048;5922.289325280994;5928.584999050025 04:04:46 INFO - PROCESS | 1653 | |1;ext.html;520.8593180933752;526.3999041093157;532.0078054428491;532.140592942398;533.7064614462047;40268.395974060375;41844.79077604615;41865;41984;43695.12609747811;34857.65142348576;42932.78533607336;43301.13397732044;43445.34831977523;43621.345679814825;7447.88828167578;8595.871061934076;9481.194098501635;9637.855432168522;9639.036096390375;8058.5970701464985;8093.352531797442;9491.098345657152;9609.471479068648;9630.47032413217;9601.951990240039;9603.231741460666;9620.134187923086;9620.230381569492;9633.759156021086;8112.959435202845;9568.138867501924;9597.712068637951;9611.711648650517;9637.421754694671;8031.839363212762;9199.448033118035;9497.382670126488;9578.281628877861;9585.376950498265;39944.80027599844;40515.39226911599;40588.98527536835;40877.1824563507;40974.59025409738;3290.96709032909;3389.67798059184;3420.1278673937986;3450.603180634234;3759;27283.86358068197;27868.860655696793;31458.528122078187;32195;32213.355732885444;3191.569138166341;3208.069659798679;3236.660150684191;3246.772725909187;3300.8679652813858;436513;446554;492447;493763;496000.0399996026;56428.43571564232;60933.69533152306;61123.38876611266;61150.69424652848;61214.69392653008;65170;66008;66101.33898660952;66387.00419493711;66486;15929.362825487082;15957.68084638324;15999.760003599955;16146.919265403598;16159.43441979525;12252.081093917814;12279.508819647113;12334;12369.010479161645;12391.318477483825;14701.852981470049;16818.495445136665;18133.637327253382;18140.63718725618;18152.636947261246;3219.8873039443506;7086.893696594555;7261.455390845602;7300.780976570712;7364;842.2966822703112;945.8675785390051;981.8969008254173;1040.2042437535292;1147.1339138950038;29855.85072074669;30479.69520304813;30824.691753082632;31142.84428577888;31430;1002.3284399452239;1074.9355038697547;1132.671525257666;1132.9660110196708;1214.8724383939737;14055.086419382707;15380.692386152214;15586.532404027897;16871.578210544834;17323.56691082733;518945;654314.7284263548;655824;660343;669456;51199;59522;60581.69709151426;61058.694706526185;61287;1363.1071648070529;1371.492547757336;1391.8538553451945;1412.7315809996069;1413.8939579531577;30748.385032299677;31620.525692115098;31766.841165794947;31786.841065794524;32317.676823231468;52058;52689;52974;52986.20520692116;54035.729821350644;591358;600954;601426.9857301371;601667;606167;25976.74023259819;26008.60987085233;26259.606105908046;26399.868000659873;26458.338541535846;47322.29016564685;47437;47806;48675;48795.75602122109;38525.42211866768;39714.60285397225;40180;40408.59591404048;41350.37974430446;39629.40555891606;39819.800900996466;40538;40799.18401631891;41239.1752164949;38440;39054.2189156221;39134;39444;41309.58690413057;30983.845080774452;34991.82504087463;35321.29357412889;35494.97562431681;35766.821165894005;25474.617880732174;25527.106551270615;25660.871695641403;25751.227463176136;26158.215253542425 04:04:46 INFO - PROCESS | 1653 | |2;jquery.html;371.45025362463554;372.5789857461069;379.41001742290734;382.1973854904702;400.707483537018;18830.058497075144;19891.801081989175;19930.903800290977;20088.49778755532;20118.597628047468;19553.608927821435;20474.07866646001;20794;20888;21154.836483993375;5767.336756273019;5779;6021.969890150565;6070.059140833156;6092.482139018189;4136.172765446922;4357.542458041908;5895.410458954092;6021.307549631782;6030.065339872327;6270.3729627037155;6549.279579246303;6631.93368066318;6687.164104486939;6696.698648560802;6102.816915492543;6633.8341541461605;6677.799666010027;6682.966585167067;6693.062971184038;5708.20085188074;5761.135829625548;5788.0739081746715;5791.82624521265;5811.041178205591;25302.873485632637;25434.618480722806;25650.486990260277;25653.871730641415;25939.351516212057;2165.8375621828427;2235.3294011796397;2253;2392.928212153638;2936.015152343703;14666.266686665624;15449.382024718998;15732.764008539882;15767.842321576867;15833;1622.9026258424533;1773.632201011638;1803.8275121171212;1810.7102863541902;1824.4891430399377;87938;116348;117233;126547.36726316309;131326.68673313336;10034.949825250973;10259.384436933808;11551.942240288745;11580.710482238012;11668.358240296866;14491.78262326066;14656.487022954145;14657.04729192599;14682.119072855663;14700;8218.260356567818;8535.359848011423;8556.401051926305;8601.22588966996;8675.262602678842;6863;6914;7019.964900175569;7700.5379677218425;8506;3402.6937575618313;3907.5506316773367;4234.978825105854;4367.563243675607;4636.513166117509;1631.2496251724103;1946.5231018400582;1955.5795503966715;3756.670864064243;3831.3142217424243;816.4652152839899;907.2852309135739;955.2739917662626;982.5136557403988;995.6465454763454;19493.122809473607;21244.57510849805;21362.465938351666;21713.67429488559;21996.230131945304;922.6355589542093;935.7239614313794;948.8434408322687;980.3480685344309;1000.7848312612823;10801.189910756568;11087;11240.718982025515;11283.605073822377;11453.427328633536;596308;599942;604723;613569;614423.062500936;128540;129936;131513;133614;138706;953.6948176583427;957.9521023948774;981.5092453773113;983.2772911909741;985.5959056786683;19003.334883279018;19143.712844307625;19271.421857344303;19314.71027934554;19341.4197574073;52168.69578260422;57015.57461063506;57193.71403143124;58035.419645803;58175;69724.6513767428;81301.18698812937;82670;83503.16496834953;84079.15920840958;7910.367170626451;8069.677212911418;8385.58072096405;8408.495490270603;8540.70107546233;9195.77010574741;12096.366990456176;13083.345832708517;13096.672583185496;13100.803487947498;10763.946180269362;11121.221514494231;11288.94355528217;11296.717582060186;11407.144464165054;10575.524101415302;10996.560137594406;11144.888551114385;11338;11437.313761174357;10928.781424371628;11321.943390282995;11684.357360345262;11762.647120586396;11928.045756339645;7127.14474263071;8133.959330203548;8178.550179739934;8360.749177524684;8400.621972011397;10742.83885741699;10826.350418974887;11413.486393112164;11476.4261786912;11510.884891151316 04:04:46 INFO - PROCESS | 1653 | |3;mootools.html;1529.4723320454443;1561.9375224991;1746.6768647800166;1809.9819001809979;1877.849772018238;7825.0218722659665;8087.433879628428;8271.379646526511;8849.690260840864;8878.467291962479;8336.333093352532;8583.828323433527;8586.184312490319;8656.13438656134;8697.565121743903;2302.4704318006825;2321.187584345474;2322.6167682332393;2329.1964272326104;2339.2865176121363;2276.362618466832;2317.9304620861403;2318.5826551220775;2329.499157681098;2330.3125577954543;2303.424143964009;2321.419645088728;2323.674685544025;2330.487292795582;2342.508073304608;2286.5084006938423;2298.9425264368524;2301.5627030864166;2302.620067688821;2304.089884495623;2252.40311317501;2277.601419751537;2280.7149106361703;2288.416453804286;2292.33522278539;7457.552546847152;7471.887921681179;8711.912880871238;8833.646654133827;8866.556672166365;4580.656450766206;5196.792128314863;5243.9213411798855;5336.759845806948;5371.704556249405;3344.130526063241;3479.425894727367;3579.588347340037;3656;3662.0661731258624;1007.7682133109425;1038.2576457832686;1078.5062688176854;1078.8112080385902;1089.1232557790975;9247.39891907024;10568.418736969386;10591.152707783358;11366.318020918688;11464.426778661034;3992.401139829049;4428.070105277863;4592.7933243004145;4676.158291507561;4705.529447055267;9674.22606191503;9750.463724495079;9797.412155270564;9836.458994755358;9859.309848310693;4662.393888794503;5302.257683924254;5316.441773613792;5326.201069839478;5334.11987022137;4306.763128027926;4363.890902727394;4645.721256724607;4679.906401871944;4765.5949244314625;3781.810909454516;3818.453526321844;3902.1415288636454;3924.4898163238595;3944.171723938005;1132.7791080739178;1218.232513516479;1280.3022352817736;1290.4451086033096;1301.73965206959;739.4397820598533;835.5613303015843;904.7873749668822;906.6373450619805;928.7353104365359;5648.124540696199;5656.547476201894;5804.042333015005;5810.215620891126;5943.31651860033;911.3529394130242;913.3971578757988;956.8564715292623;962.3456049886145;974.5906719177821;3725.925481490355;3784.3188226119564;3787.0721673189696;3875.0312421894528;3927.9803600981813;7177.9641101795205;9096.272298216127;10195.796084078276;10199.9490002551;10233.283670143019;10050.949745251228;10196.898031019744;10201.591936322464;10224.488775561342;10226.744331391626;7656.081270247494;8051.4766540174705;8193.385496087698;8211.753647390588;8222.013358397031;5715.542756579547;5784.161296612052;5805.912911306249;5865.120231965239;5919.437653422918;9467.147956683932;9611.327207095435;9625.855612165684;9718.368306060083;9750.80498390014;9433.339666223299;9751.609935602497;9826.65606703762;9958.502074896081;9981.951895051205;5981.491573216325;6834.316568343126;7048.330408611174;7340.412766978736;7520.360769334668;7920.089189743023;8203.630836612487;8289.58552072406;8304.418690691835;8364.749057528285;7299.452541059548;7401.925980740339;7411.0736157980255;7521.924780752122;7544.321011108807;7156.212816590067;7268.9273107270365;7270.636468176675;7321.6705248265025;7450.776476705708;6827.385535301847;6938.791836244921;6947.270536593584;6950.4787140965645;6969.372756451741;4807.759612019455;4837.395325584302;4956.3804524434445;4988.5260900214425;4996.925046124384;4880.1215781159735;4938.629602779878;5003.4246061701915;5061.4432412435335;5149.897002060013 04:04:46 INFO - PROCESS | 1653 | |4;prototype.html;293.3458387795215;298.3987265659695;305.781366323079;307.77532401347;310.95024796032624;4620.851304143573;4879.292502587123;4881.292212629167;5587.547237718197;5609.214709940612;4513.526079761618;4515.864524064284;4879.53644403782;5503.642263252896;5515.255440515529;3496.5454490916272;3499.7900125992396;4169.3537501687215;4203.894902627443;4213.241616509027;4029.738067025634;4224.66202703783;4246.617804397603;4260.275753121961;4260.510041345238;3651.269746050787;3954.1498577805764;4142.508696869125;4164.66682665386;4165.854195103172;4036.2936486114813;4089.447924530195;4160.375943608453;4191.874243772691;4199.580041995776;3638.435472746718;3644.5444319460066;3648.3615367310613;3649;3680.5215322008235;5037.874053148664;5387.171734839201;5398.002738986561;5426.8371948841595;5455;4724.4094488188975;4729.62163026957;4751.548602882721;4756.881077973044;4761.547652972962;5677.243871326376;5833.854153646151;5857.092150716646;5857.502112320458;5914.9112763308585;3893.532776066862;3902.453656488094;3907.238088572701;3910.276598829197;3914.6868250539887;5486.655769336498;5542.953643839979;5734.111212762028;6087.847803804941;6139.662318572477;3944.3491823849317;3953.9604603954167;3983.900402489903;3984.7210695251056;4014.698897582693;3517.700995415418;3790.7156963227867;3954.6045395460224;4039.7980100994832;4104.384342348611;4746.620270378361;4747.667663263538;4767.404074490689;4770.189067858472;4772.6420518461255;4847.75761211938;4857.684250523705;5872.942870283305;5896.852578685567;5960.910586341121;1173.184636677518;1179.5517703272874;1255.5480027190204;1299.8505171905163;1359.8572149924314;804.955727434985;819.8073452738602;840.9873851892227;841.2765022081005;841.3059226138461;3706.6293370663257;4225.605550168437;4280.245099509187;4501.122281155143;4561.908761824745;4334.421019493397;4576.98612610457;4875.536824001714;4982.427020892571;4994.352992913761;4455.262447645421;4482.305242687388;4557.931631025537;4575.382323386367;4729.858104256878;2394.985314699076;2532.544142054411;2534.5817940040056;2609.569421045544;2651.403434227322;4715.57559819611;4870.902581948412;4980.2778597103215;5021.548060674557;5241.633085684041;4094.467719196485;4755.381800366;4878.999610159817;5136.123770688427;5263.36839579253;3967.781772002568;4337.414449049401;4748;5071.923921141112;5106.106431374495;4524.018863400187;4787.8563643090765;4991.825286114969;4999.975000124976;5040.924386134137;4297.398364228948;4482;4770.592675160905;5074.619403544675;5086.796528138833;4486.50648428666;4775.296333111952;4834.806607735652;5171.715555644476;5174.637775355689;3127.499600063979;3142.402943440739;3423.691867731916;3475.061733332037;3490.5636795400574;4620.973262513059;4990.700557966534;4998.725070121032;5013.924791128209;5021.397432308;5105.642605017613;5572.60991730575;5813.476787089182;5819.970900145472;5895.730143894546;4946.282788995503;5819.447152520504;5833.708314584169;5845.678487683218;5856.297244330707;4725.740084295259;5590.630295577609;5699.401562835843;5726.506830833105;5789.2763404574425;5118.899436621145;5126.743662816919;5789.536837052941;5879.823605291848;5936.851578710567;4668.0860847052545;5737.454941780524;5788.27646544182;5810.82567522975;5825.3592104867585 04:04:46 INFO - PROCESS | 1653 | |5;yui.html;712.3126183233179;719.7804669575779;752.53342927385;790.5533373643894;825.9091499935008;15064.472743453982;15434.151121688303;15673.843261567381;15704.842951570467;15805.288762005708;14221.928890355559;14266.429342826275;14387.424503019893;14395.2082635455;14441;761.7486229544265;856.2037305306047;876.2201640539924;884.2925659472428;885.6723012485389;854.4744981836158;874.6501399440243;875.6366108065146;878.4685265414428;880;932.3939439364433;932.822763674903;933.3886304470583;934.1452570897654;935.4621092871593;893.8837951066384;923.8013827027221;925.7407925780758;927.0127314410132;929.2705226397246;671.5366397185926;680.1158493957885;692.1313751242209;692.435664933083;693.5457275484565;13034.543790967366;13221.73556528864;13259.204447733167;13894.957878159179;14527.927360363235;11802;13158.86841131586;13367.598972030855;13711.245881476514;13923.48776673615;11213.551457941672;11692.298462092302;11694.415279236004;11734.941325293405;11893.167478276524;3660.8352624131976;3697.3714468540143;3698.8335524901177;3713.4801127842125;3847.903802404934;80181.59909200417;80879.59560202161;94690;98289.5085524575;100615;9175.862362064574;10687.62593309246;10853.73727340452;10962.616308429167;11068.667939961813;20554;20757.37727868136;20776.376708698765;20788.480287992923;20794.48013799637;5374.946250537523;7639.784462505922;7826.217378262242;7986.720464783704;7991.560464174526;4176.728512646669;4332.068605249887;4347.130573885235;4355.825766969286;4373.125374925028;3425.9143521411665;3537.080359106599;3560.127768696686;3582.964170358315;3590.6588874056924;645.4191227894838;645.8826230621052;657.5581943968463;664.4319107163402;665.55075324156;544.3250369541819;569.1945896556326;591.3790519954117;639.6545865232722;662.2218892800939;7675.848622706639;7722.53664780115;8104.797380065427;8938.284937205008;9118.908810911938;455.68557695190214;559.7732918168149;571.8610713985364;610.8167549735061;634.7112064010864;4295.312749959991;4382.6055654991205;4533.569310915524;4546.431696037996;4619.653525985565;106701.46649266704;109856.4507177475;111623;113023;115679;81046;85466.71799923007;86085.56957215299;87246.56376718203;102020.97979020263;73260.53478930391;73351.63324183345;76868.84696729554;88593.55703221442;89023.66464503038;9401.247900168108;9541.034597554337;9560.856587151338;9578.425294482353;9649;54013.91972160614;54125;54995.72502137464;55505.72247138739;56864.14703779364;67821.60891955481;69467.65266173637;71723.28276717375;75196.62401687956;76571;12376.690582735504;12574.434150463068;12606.306653134166;12929.935350323189;13325.866741332462;13419.127756695783;14037.859621403655;14245.430182792572;14288.642783930485;14354.641133971734;13002.544910928073;13033.804492932803;13296.268705221306;13418.798718019432;13487;12920.806187907001;12922;13125.60623181306;13323.267220302589;13791.310434478035;10485.528151233366;12684.492620295454;13122.934385328012;13147.342632868127;13466.124701894345;10592.8940710595;10610.52252648648;10683.459311276656;10790.622328218475;11033.889661103607;9369.531523423666;9633.22934165251;9860.901390986286;11122.499487522919;11200.38397888124 04:04:46 INFO - PROCESS | 1653 | __end_tp_report 04:04:46 INFO - PROCESS | 1653 | __start_cc_report 04:04:46 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,363 04:04:46 INFO - PROCESS | 1653 | __end_cc_report 04:04:46 INFO - PROCESS | 1653 | __startTimestamp1477393486835__endTimestamp 04:04:46 INFO - PROCESS | 1653 | 04:04:46 INFO - PROCESS | 1653 | ------- Summary: start ------- 04:04:46 INFO - PROCESS | 1653 | Number of tests: 6 04:04:46 INFO - PROCESS | 1653 | 04:04:46 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5641.34 Median:5870.85 stddev:682.09 (11.6%) stddev-sans-first:660.08 04:04:46 INFO - PROCESS | 1653 | Values: 3350.3 3363.3 3387.1 3392.6 3404.0 5535.7 5591.4 5608.6 5635.8 5661.3 5601.0 5619.9 5668.1 5690.8 5733.3 4604.0 4627.0 4756.5 5111.3 5299.9 5045.1 5244.5 5270.8 5274.9 5281.2 5091.5 5126.7 5132.0 5169.3 5239.7 5160.7 5216.7 5221.9 5222.3 5265.0 4233.9 4261.8 5129.7 5154.2 5160.3 4400.7 4929.7 5483.2 5528.5 5536.8 6093.4 6125.4 6153.4 6192.9 6193.3 6150.6 6160.9 6171.2 6210.9 6243.8 5646.2 5774.8 5779.4 5784.3 5816.1 5309.2 6166.5 6185.8 6192.3 6196.9 6039.8 6106.9 6115.8 6118.8 6126.8 5375.2 6013.3 6206.1 6216.7 6239.1 6067.3 6102.6 6138.4 6142.9 6147.4 6160.6 6161.8 6173.0 6194.3 6229.1 4916.0 4917.2 4921.0 4922.3 4928.2 4334.4 4341.8 4345.5 4347.5 4456.6 4668.4 5764.5 5783.6 5822.5 5838.3 6110.1 6198.6 6224.6 6229.0 6240.6 5647.2 5676.6 5788.7 5790.8 5818.1 5309.7 5325.8 5358.4 5385.8 5425.9 6301.0 6304.6 6312.0 6318.0 6335.5 6063.2 6208.8 6211.0 6224.4 6225.4 6172.0 6176.5 6192.2 6212.3 6230.8 6149.0 6150.5 6155.4 6187.2 6203.4 6165.1 6177.8 6179.3 6193.4 6196.3 3791.3 5248.2 5886.5 6016.8 6050.4 5967.3 6044.4 6059.3 6088.6 6110.6 5779.4 5825.3 5867.1 5870.9 5931.9 6096.9 6112.6 6112.7 6113.9 6121.3 5913.9 5914.7 5917.4 5922.3 5928.6 04:04:46 INFO - PROCESS | 1653 | 04:04:46 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:70520.57 Median:40925.89 stddev:153319.22 (374.6%) stddev-sans-first:153659.24 04:04:46 INFO - PROCESS | 1653 | Values: 520.9 526.4 532.0 532.1 533.7 40268.4 41844.8 41865.0 41984.0 43695.1 34857.7 42932.8 43301.1 43445.3 43621.3 7447.9 8595.9 9481.2 9637.9 9639.0 8058.6 8093.4 9491.1 9609.5 9630.5 9602.0 9603.2 9620.1 9620.2 9633.8 8113.0 9568.1 9597.7 9611.7 9637.4 8031.8 9199.4 9497.4 9578.3 9585.4 39944.8 40515.4 40589.0 40877.2 40974.6 3291.0 3389.7 3420.1 3450.6 3759.0 27283.9 27868.9 31458.5 32195.0 32213.4 3191.6 3208.1 3236.7 3246.8 3300.9 436513.0 446554.0 492447.0 493763.0 496000.0 56428.4 60933.7 61123.4 61150.7 61214.7 65170.0 66008.0 66101.3 66387.0 66486.0 15929.4 15957.7 15999.8 16146.9 16159.4 12252.1 12279.5 12334.0 12369.0 12391.3 14701.9 16818.5 18133.6 18140.6 18152.6 3219.9 7086.9 7261.5 7300.8 7364.0 842.3 945.9 981.9 1040.2 1147.1 29855.9 30479.7 30824.7 31142.8 31430.0 1002.3 1074.9 1132.7 1133.0 1214.9 14055.1 15380.7 15586.5 16871.6 17323.6 518945.0 654314.7 655824.0 660343.0 669456.0 51199.0 59522.0 60581.7 61058.7 61287.0 1363.1 1371.5 1391.9 1412.7 1413.9 30748.4 31620.5 31766.8 31786.8 32317.7 52058.0 52689.0 52974.0 52986.2 54035.7 591358.0 600954.0 601427.0 601667.0 606167.0 25976.7 26008.6 26259.6 26399.9 26458.3 47322.3 47437.0 47806.0 48675.0 48795.8 38525.4 39714.6 40180.0 40408.6 41350.4 39629.4 39819.8 40538.0 40799.2 41239.2 38440.0 39054.2 39134.0 39444.0 41309.6 30983.8 34991.8 35321.3 35495.0 35766.8 25474.6 25527.1 25660.9 25751.2 26158.2 04:04:46 INFO - PROCESS | 1653 | 04:04:46 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35642.93 Median:14437.68 stddev:101154.01 (700.6%) stddev-sans-first:101403.10 04:04:46 INFO - PROCESS | 1653 | Values: 371.5 372.6 379.4 382.2 400.7 18830.1 19891.8 19930.9 20088.5 20118.6 19553.6 20474.1 20794.0 20888.0 21154.8 5767.3 5779.0 6022.0 6070.1 6092.5 4136.2 4357.5 5895.4 6021.3 6030.1 6270.4 6549.3 6631.9 6687.2 6696.7 6102.8 6633.8 6677.8 6683.0 6693.1 5708.2 5761.1 5788.1 5791.8 5811.0 25302.9 25434.6 25650.5 25653.9 25939.4 2165.8 2235.3 2253.0 2392.9 2936.0 14666.3 15449.4 15732.8 15767.8 15833.0 1622.9 1773.6 1803.8 1810.7 1824.5 87938.0 116348.0 117233.0 126547.4 131326.7 10034.9 10259.4 11551.9 11580.7 11668.4 14491.8 14656.5 14657.0 14682.1 14700.0 8218.3 8535.4 8556.4 8601.2 8675.3 6863.0 6914.0 7020.0 7700.5 8506.0 3402.7 3907.6 4235.0 4367.6 4636.5 1631.2 1946.5 1955.6 3756.7 3831.3 816.5 907.3 955.3 982.5 995.6 19493.1 21244.6 21362.5 21713.7 21996.2 922.6 935.7 948.8 980.3 1000.8 10801.2 11087.0 11240.7 11283.6 11453.4 596308.0 599942.0 604723.0 613569.0 614423.1 128540.0 129936.0 131513.0 133614.0 138706.0 953.7 958.0 981.5 983.3 985.6 19003.3 19143.7 19271.4 19314.7 19341.4 52168.7 57015.6 57193.7 58035.4 58175.0 69724.7 81301.2 82670.0 83503.2 84079.2 7910.4 8069.7 8385.6 8408.5 8540.7 9195.8 12096.4 13083.3 13096.7 13100.8 10763.9 11121.2 11288.9 11296.7 11407.1 10575.5 10996.6 11144.9 11338.0 11437.3 10928.8 11321.9 11684.4 11762.6 11928.0 7127.1 8134.0 8178.6 8360.7 8400.6 10742.8 10826.4 11413.5 11476.4 11510.9 04:04:46 INFO - PROCESS | 1653 | 04:04:46 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5527.69 Median:5273.09 stddev:3030.76 (57.5%) stddev-sans-first:3024.37 04:04:46 INFO - PROCESS | 1653 | Values: 1529.5 1561.9 1746.7 1810.0 1877.8 7825.0 8087.4 8271.4 8849.7 8878.5 8336.3 8583.8 8586.2 8656.1 8697.6 2302.5 2321.2 2322.6 2329.2 2339.3 2276.4 2317.9 2318.6 2329.5 2330.3 2303.4 2321.4 2323.7 2330.5 2342.5 2286.5 2298.9 2301.6 2302.6 2304.1 2252.4 2277.6 2280.7 2288.4 2292.3 7457.6 7471.9 8711.9 8833.6 8866.6 4580.7 5196.8 5243.9 5336.8 5371.7 3344.1 3479.4 3579.6 3656.0 3662.1 1007.8 1038.3 1078.5 1078.8 1089.1 9247.4 10568.4 10591.2 11366.3 11464.4 3992.4 4428.1 4592.8 4676.2 4705.5 9674.2 9750.5 9797.4 9836.5 9859.3 4662.4 5302.3 5316.4 5326.2 5334.1 4306.8 4363.9 4645.7 4679.9 4765.6 3781.8 3818.5 3902.1 3924.5 3944.2 1132.8 1218.2 1280.3 1290.4 1301.7 739.4 835.6 904.8 906.6 928.7 5648.1 5656.5 5804.0 5810.2 5943.3 911.4 913.4 956.9 962.3 974.6 3725.9 3784.3 3787.1 3875.0 3928.0 7178.0 9096.3 10195.8 10199.9 10233.3 10050.9 10196.9 10201.6 10224.5 10226.7 7656.1 8051.5 8193.4 8211.8 8222.0 5715.5 5784.2 5805.9 5865.1 5919.4 9467.1 9611.3 9625.9 9718.4 9750.8 9433.3 9751.6 9826.7 9958.5 9982.0 5981.5 6834.3 7048.3 7340.4 7520.4 7920.1 8203.6 8289.6 8304.4 8364.7 7299.5 7401.9 7411.1 7521.9 7544.3 7156.2 7268.9 7270.6 7321.7 7450.8 6827.4 6938.8 6947.3 6950.5 6969.4 4807.8 4837.4 4956.4 4988.5 4996.9 4880.1 4938.6 5003.4 5061.4 5149.9 04:04:46 INFO - PROCESS | 1653 | 04:04:46 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4371.98 Median:4749.77 stddev:1337.52 (28.2%) stddev-sans-first:1305.77 04:04:46 INFO - PROCESS | 1653 | Values: 293.3 298.4 305.8 307.8 311.0 4620.9 4879.3 4881.3 5587.5 5609.2 4513.5 4515.9 4879.5 5503.6 5515.3 3496.5 3499.8 4169.4 4203.9 4213.2 4029.7 4224.7 4246.6 4260.3 4260.5 3651.3 3954.1 4142.5 4164.7 4165.9 4036.3 4089.4 4160.4 4191.9 4199.6 3638.4 3644.5 3648.4 3649.0 3680.5 5037.9 5387.2 5398.0 5426.8 5455.0 4724.4 4729.6 4751.5 4756.9 4761.5 5677.2 5833.9 5857.1 5857.5 5914.9 3893.5 3902.5 3907.2 3910.3 3914.7 5486.7 5543.0 5734.1 6087.8 6139.7 3944.3 3954.0 3983.9 3984.7 4014.7 3517.7 3790.7 3954.6 4039.8 4104.4 4746.6 4747.7 4767.4 4770.2 4772.6 4847.8 4857.7 5872.9 5896.9 5960.9 1173.2 1179.6 1255.5 1299.9 1359.9 805.0 819.8 841.0 841.3 841.3 3706.6 4225.6 4280.2 4501.1 4561.9 4334.4 4577.0 4875.5 4982.4 4994.4 4455.3 4482.3 4557.9 4575.4 4729.9 2395.0 2532.5 2534.6 2609.6 2651.4 4715.6 4870.9 4980.3 5021.5 5241.6 4094.5 4755.4 4879.0 5136.1 5263.4 3967.8 4337.4 4748.0 5071.9 5106.1 4524.0 4787.9 4991.8 5000.0 5040.9 4297.4 4482.0 4770.6 5074.6 5086.8 4486.5 4775.3 4834.8 5171.7 5174.6 3127.5 3142.4 3423.7 3475.1 3490.6 4621.0 4990.7 4998.7 5013.9 5021.4 5105.6 5572.6 5813.5 5820.0 5895.7 4946.3 5819.4 5833.7 5845.7 5856.3 4725.7 5590.6 5699.4 5726.5 5789.3 5118.9 5126.7 5789.5 5879.8 5936.9 4668.1 5737.5 5788.3 5810.8 5825.4 04:04:46 INFO - PROCESS | 1653 | 04:04:46 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:20353.60 Median:4540.00 stddev:29572.32 (651.4%) stddev-sans-first:29618.51 04:04:46 INFO - PROCESS | 1653 | Values: 712.3 719.8 752.5 790.6 825.9 15064.5 15434.2 15673.8 15704.8 15805.3 14221.9 14266.4 14387.4 14395.2 14441.0 761.7 856.2 876.2 884.3 885.7 854.5 874.7 875.6 878.5 880.0 932.4 932.8 933.4 934.1 935.5 893.9 923.8 925.7 927.0 929.3 671.5 680.1 692.1 692.4 693.5 13034.5 13221.7 13259.2 13895.0 14527.9 11802.0 13158.9 13367.6 13711.2 13923.5 11213.6 11692.3 11694.4 11734.9 11893.2 3660.8 3697.4 3698.8 3713.5 3847.9 80181.6 80879.6 94690.0 98289.5 100615.0 9175.9 10687.6 10853.7 10962.6 11068.7 20554.0 20757.4 20776.4 20788.5 20794.5 5374.9 7639.8 7826.2 7986.7 7991.6 4176.7 4332.1 4347.1 4355.8 4373.1 3425.9 3537.1 3560.1 3583.0 3590.7 645.4 645.9 657.6 664.4 665.6 544.3 569.2 591.4 639.7 662.2 7675.8 7722.5 8104.8 8938.3 9118.9 455.7 559.8 571.9 610.8 634.7 4295.3 4382.6 4533.6 4546.4 4619.7 106701.5 109856.5 111623.0 113023.0 115679.0 81046.0 85466.7 86085.6 87246.6 102021.0 73260.5 73351.6 76868.8 88593.6 89023.7 9401.2 9541.0 9560.9 9578.4 9649.0 54013.9 54125.0 54995.7 55505.7 56864.1 67821.6 69467.7 71723.3 75196.6 76571.0 12376.7 12574.4 12606.3 12929.9 13325.9 13419.1 14037.9 14245.4 14288.6 14354.6 13002.5 13033.8 13296.3 13418.8 13487.0 12920.8 12922.0 13125.6 13323.3 13791.3 10485.5 12684.5 13122.9 13147.3 13466.1 10592.9 10610.5 10683.5 10790.6 11033.9 9369.5 9633.2 9860.9 11122.5 11200.4 04:04:46 INFO - PROCESS | 1653 | -------- Summary: end -------- 04:04:46 INFO - PROCESS | 1653 | 04:04:47 INFO - TEST-INFO | 1653: exit 0 04:04:47 INFO - TEST-OK | dromaeo_css | took 1115177ms 04:04:47 INFO - TEST-START | kraken 04:04:47 INFO - operating with platform_type : mac_ 04:04:47 INFO - Initialising browser for kraken test... 04:04:47 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpf1HyW5/profile http://localhost:49273/getInfo.html) 04:04:50 INFO - PROCESS | 1669 | 2016-10-25 04:04:50.167 plugin-container[1670:10279] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 04:04:50 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:04:50 INFO - PROCESS | 1669 | 2016-10-25 04:04:50.170 plugin-container[1670:10279] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4723, name = 'com.apple.CFPasteboardClient' 04:04:50 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:04:50 INFO - PROCESS | 1669 | 2016-10-25 04:04:50.170 plugin-container[1670:10279] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:04:50 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 04:04:50 INFO - PROCESS | 1669 | colorDepth:24 04:04:50 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 04:04:50 INFO - PROCESS | 1669 | __metrics 04:04:50 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 04:04:51 INFO - TEST-INFO | 1669: exit 0 04:04:51 INFO - Browser initialized. 04:04:51 INFO - Running cycle 1/1 for kraken test... 04:04:51 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpf1HyW5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:53 INFO - PROCESS | 1671 | 2016-10-25 04:04:53.708 plugin-container[1672:10394] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 04:04:53 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:04:53 INFO - PROCESS | 1671 | 2016-10-25 04:04:53.709 plugin-container[1672:10394] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 04:04:53 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:04:53 INFO - PROCESS | 1671 | 2016-10-25 04:04:53.709 plugin-container[1672:10394] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:05:03 INFO - PROCESS | 1671 | RSS: Main: 236318720 04:05:03 INFO - PROCESS | 1671 | 04:05:06 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 04:05:07 INFO - PROCESS | 1671 | RSS: Main: 248815616 04:05:07 INFO - PROCESS | 1671 | 04:05:10 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 04:05:10 INFO - PROCESS | 1671 | RSS: Main: 256344064 04:05:10 INFO - PROCESS | 1671 | 04:05:13 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 04:05:14 INFO - PROCESS | 1671 | RSS: Main: 259346432 04:05:14 INFO - PROCESS | 1671 | 04:05:16 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 04:05:17 INFO - PROCESS | 1671 | RSS: Main: 261545984 04:05:17 INFO - PROCESS | 1671 | 04:05:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:05:19 INFO - PROCESS | 1671 | RSS: Main: 262045696 04:05:19 INFO - PROCESS | 1671 | 04:05:22 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 04:05:23 INFO - PROCESS | 1671 | RSS: Main: 262766592 04:05:23 INFO - PROCESS | 1671 | 04:05:26 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 04:05:26 INFO - PROCESS | 1671 | RSS: Main: 262692864 04:05:26 INFO - PROCESS | 1671 | 04:05:29 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 04:05:30 INFO - PROCESS | 1671 | RSS: Main: 263233536 04:05:30 INFO - PROCESS | 1671 | 04:05:31 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:05:32 INFO - PROCESS | 1671 | RSS: Main: 262815744 04:05:32 INFO - PROCESS | 1671 | 04:05:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:05:35 INFO - PROCESS | 1671 | RSS: Main: 262959104 04:05:35 INFO - PROCESS | 1671 | 04:05:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:05:38 INFO - PROCESS | 1671 | RSS: Main: 262938624 04:05:38 INFO - PROCESS | 1671 | 04:05:41 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:05:41 INFO - PROCESS | 1671 | RSS: Main: 263516160 04:05:41 INFO - PROCESS | 1671 | 04:05:44 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:05:45 INFO - PROCESS | 1671 | RSS: Main: 263315456 04:05:45 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 04:05:47 INFO - PROCESS | 1671 | RSS: Main: 265089024 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | __start_tp_report 04:05:47 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 04:05:47 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 04:05:47 INFO - PROCESS | 1671 | |i|pagename|runs| 04:05:47 INFO - PROCESS | 1671 | |0;ai-astar;105;116;119;117;141;157;117;115;116;117 04:05:47 INFO - PROCESS | 1671 | |1;audio-beat-detection;139;137;144;184;115;115;113;118;145;130 04:05:47 INFO - PROCESS | 1671 | |2;audio-dft;211;207;207;200;197;197;246;209;196;196 04:05:47 INFO - PROCESS | 1671 | |3;audio-fft;81;58;59;85;61;61;60;59;79;58 04:05:47 INFO - PROCESS | 1671 | |4;audio-oscillator;81;70;86;71;70;69;114;54;78;117 04:05:47 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;91;87;89;85;102;86;91;87;106;131 04:05:47 INFO - PROCESS | 1671 | |6;imaging-darkroom;95;97;95;95;99;96;134;92;134;95 04:05:47 INFO - PROCESS | 1671 | |7;imaging-desaturate;97;92;86;84;117;85;77;140;134;90 04:05:47 INFO - PROCESS | 1671 | |8;json-parse-financial;55;58;55;59;58;61;61;90;88;89 04:05:47 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;69;74;77;77;79;87;61;69;81;104 04:05:47 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;89;89;114;113;110;111;93;90;94;94 04:05:47 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;141;153;163;161;165;163;146;154;194;149 04:05:47 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;174;176;237;174;173;173;174;176;174;177 04:05:47 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;68;69;72;68;72;76;78;84;71;62 04:05:47 INFO - PROCESS | 1671 | __end_tp_report 04:05:47 INFO - PROCESS | 1671 | __start_cc_report 04:05:47 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,961 04:05:47 INFO - PROCESS | 1671 | __end_cc_report 04:05:47 INFO - PROCESS | 1671 | __startTimestamp1477393547475__endTimestamp 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | ------- Summary: start ------- 04:05:47 INFO - PROCESS | 1671 | Number of tests: 14 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:122.00 Median:117.00 stddev:15.20 (13.0%) stddev-sans-first:14.83 04:05:47 INFO - PROCESS | 1671 | Values: 105.0 116.0 119.0 117.0 141.0 157.0 117.0 115.0 116.0 117.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:138.00 stddev:21.58 (15.6%) stddev-sans-first:22.81 04:05:47 INFO - PROCESS | 1671 | Values: 139.0 137.0 144.0 184.0 115.0 115.0 113.0 118.0 145.0 130.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:206.60 Median:207.00 stddev:15.02 (7.3%) stddev-sans-first:15.85 04:05:47 INFO - PROCESS | 1671 | Values: 211.0 207.0 207.0 200.0 197.0 197.0 246.0 209.0 196.0 196.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.00 stddev:10.89 (17.8%) stddev-sans-first:10.13 04:05:47 INFO - PROCESS | 1671 | Values: 81.0 58.0 59.0 85.0 61.0 61.0 60.0 59.0 79.0 58.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:81.00 Median:70.50 stddev:20.09 (28.5%) stddev-sans-first:21.31 04:05:47 INFO - PROCESS | 1671 | Values: 81.0 70.0 86.0 71.0 70.0 69.0 114.0 54.0 78.0 117.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:95.50 Median:87.00 stddev:14.30 (16.4%) stddev-sans-first:15.07 04:05:47 INFO - PROCESS | 1671 | Values: 91.0 87.0 89.0 85.0 102.0 86.0 91.0 87.0 106.0 131.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:103.20 Median:95.00 stddev:16.33 (17.2%) stddev-sans-first:17.05 04:05:47 INFO - PROCESS | 1671 | Values: 95.0 97.0 95.0 95.0 99.0 96.0 134.0 92.0 134.0 95.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:100.20 Median:85.50 stddev:22.17 (25.9%) stddev-sans-first:23.48 04:05:47 INFO - PROCESS | 1671 | Values: 97.0 92.0 86.0 84.0 117.0 85.0 77.0 140.0 134.0 90.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:61.00 stddev:15.05 (24.7%) stddev-sans-first:15.28 04:05:47 INFO - PROCESS | 1671 | Values: 55.0 58.0 55.0 59.0 58.0 61.0 61.0 90.0 88.0 89.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:77.80 Median:77.00 stddev:11.72 (15.2%) stddev-sans-first:11.99 04:05:47 INFO - PROCESS | 1671 | Values: 69.0 74.0 77.0 77.0 79.0 87.0 61.0 69.0 81.0 104.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:99.70 Median:89.50 stddev:10.79 (12.1%) stddev-sans-first:10.73 04:05:47 INFO - PROCESS | 1671 | Values: 89.0 89.0 114.0 113.0 110.0 111.0 93.0 90.0 94.0 94.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:158.90 Median:162.00 stddev:14.72 (9.1%) stddev-sans-first:14.12 04:05:47 INFO - PROCESS | 1671 | Values: 141.0 153.0 163.0 161.0 165.0 163.0 146.0 154.0 194.0 149.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:175.00 stddev:19.79 (11.3%) stddev-sans-first:20.84 04:05:47 INFO - PROCESS | 1671 | Values: 174.0 176.0 237.0 174.0 173.0 173.0 174.0 176.0 174.0 177.0 04:05:47 INFO - PROCESS | 1671 | 04:05:47 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:6.13 (8.5%) stddev-sans-first:6.33 04:05:47 INFO - PROCESS | 1671 | Values: 68.0 69.0 72.0 68.0 72.0 76.0 78.0 84.0 71.0 62.0 04:05:47 INFO - PROCESS | 1671 | -------- Summary: end -------- 04:05:47 INFO - PROCESS | 1671 | 04:05:48 INFO - TEST-INFO | 1671: exit 0 04:05:48 INFO - TEST-OK | kraken | took 60811ms 04:05:48 INFO - SUITE-END | took 1175s 04:05:48 INFO - Completed test suite (00:19:36) 04:05:48 INFO - javascript benchmark 04:05:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7224.210963985209, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3350.313185796909, 3363.344147891161, 3387.102417859268, 3392.5759280089974, 3403.9829800850994, 5535.723213839312, 5591.356993945703, 5608.635438696482, 5635.802746903859, 5661.2923384576925, 5600.991821472134, 5619.915701264485, 5668.093105103184, 5690.800821971222, 5733.340665823432, 4603.987122832971, 4626.958934239786, 4756.453007904083, 5111.309973153632, 5299.894002119955, 5045.142325804622, 5244.475552444744, 5270.7628156733035, 5274.918641678447, 5281.155015197569, 5091.516305950929, 5126.71803050832, 5132.024915266087, 5169.2504586835075, 5239.659422137549, 5160.690358578498, 5216.747980484656, 5221.947780522184, 5222.3472065991755, 5265.0259701955265, 4233.915321693579, 4261.808218630169, 5129.717865517395, 5154.201098829687, 5160.25176349431, 4400.713953593006, 4929.6795708279205, 5483.2049352844015, 5528.474794894479, 5536.750846211889, 6093.421124993119, 6125.448709616156, 6153.446189842935, 6192.87614247717, 6193.318734939153, 6150.600210986271, 6160.8767824643255, 6171.197744293213, 6210.875782484325, 6243.8126856194385, 5646.181303710939, 5774.797882074149, 5779.422057794271, 5784.305883294031, 5816.098504731731, 5309.230161626542, 6166.506679465632, 6185.752569897244, 6192.318844927055, 6196.8760624787255, 6039.818805435844, 6106.938930610637, 6115.785947491817, 6118.847028824315, 6126.78556250538, 5375.220593013991, 6013.338532761392, 6206.10011548332, 6216.658083805343, 6239.0953311770445, 6067.332593414721, 6102.603330783485, 6138.355472675305, 6142.928535732134, 6147.415995480422, 6160.568760186834, 6161.84595385119, 6173.0, 6194.287656919512, 6229.0967809667345, 4916.0, 4917.164082106051, 4921.0, 4922.261660750844, 4928.236123400879, 4334.436523251957, 4341.848035318749, 4345.500267469219, 4347.456567929009, 4456.5766252205985, 4668.369770080995, 5764.538836893039, 5783.566232532493, 5822.475977162076, 5838.2702162229725, 6110.083487476825, 6198.6280823149855, 6224.62652240867, 6229.0, 6240.625562466175, 5647.152927060892, 5676.574256930747, 5788.681622510802, 5790.7973220937065, 5818.127280907813, 5309.734513274321, 5325.840224793263, 5358.356997160366, 5385.8114965976, 5425.864353391197, 6301.0, 6304.621722696653, 6312.0, 6317.96841015792, 6335.493160547145, 6063.211782468427, 6208.81373558794, 6211.0, 6224.439800417984, 6225.439710425902, 6172.043333283348, 6176.536759742948, 6192.164057852132, 6212.254529456494, 6230.813075607739, 6149.0, 6150.50795936333, 6155.446009859134, 6187.195664563578, 6203.4416902479, 6165.136880836776, 6177.752889884354, 6179.28938172098, 6193.38066193377, 6196.256449226122, 3791.279656865187, 5248.186531087687, 5886.470217680429, 6016.789412370546, 6050.394960503914, 5967.283925928743, 6044.425779550936, 6059.3334733178435, 6088.634681919099, 6110.602810817282, 5779.393163717749, 5825.330087040044, 5867.061270196748, 5870.853228669317, 5931.851703707269, 6096.878062438637, 6112.602680825732, 6112.74665817949, 6113.877722445437, 6121.296050954019, 5913.91129133072, 5914.674692891932, 5917.408259174048, 5922.289325280994, 5928.584999050025], "value": 5598.918556080123, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.8593180933752, 526.3999041093157, 532.0078054428491, 532.140592942398, 533.7064614462047, 40268.395974060375, 41844.79077604615, 41865.0, 41984.0, 43695.12609747811, 34857.65142348576, 42932.78533607336, 43301.13397732044, 43445.34831977523, 43621.345679814825, 7447.88828167578, 8595.871061934076, 9481.194098501635, 9637.855432168522, 9639.036096390375, 8058.5970701464985, 8093.352531797442, 9491.098345657152, 9609.471479068648, 9630.47032413217, 9601.951990240039, 9603.231741460666, 9620.134187923086, 9620.230381569492, 9633.759156021086, 8112.959435202845, 9568.138867501924, 9597.712068637951, 9611.711648650517, 9637.421754694671, 8031.839363212762, 9199.448033118035, 9497.382670126488, 9578.281628877861, 9585.376950498265, 39944.80027599844, 40515.39226911599, 40588.98527536835, 40877.1824563507, 40974.59025409738, 3290.96709032909, 3389.67798059184, 3420.1278673937986, 3450.603180634234, 3759.0, 27283.86358068197, 27868.860655696793, 31458.528122078187, 32195.0, 32213.355732885444, 3191.569138166341, 3208.069659798679, 3236.660150684191, 3246.772725909187, 3300.8679652813858, 436513.0, 446554.0, 492447.0, 493763.0, 496000.0399996026, 56428.43571564232, 60933.69533152306, 61123.38876611266, 61150.69424652848, 61214.69392653008, 65170.0, 66008.0, 66101.33898660952, 66387.00419493711, 66486.0, 15929.362825487082, 15957.68084638324, 15999.760003599955, 16146.919265403598, 16159.43441979525, 12252.081093917814, 12279.508819647113, 12334.0, 12369.010479161645, 12391.318477483825, 14701.852981470049, 16818.495445136665, 18133.637327253382, 18140.63718725618, 18152.636947261246, 3219.8873039443506, 7086.893696594555, 7261.455390845602, 7300.780976570712, 7364.0, 842.2966822703112, 945.8675785390051, 981.8969008254173, 1040.2042437535292, 1147.1339138950038, 29855.85072074669, 30479.69520304813, 30824.691753082632, 31142.84428577888, 31430.0, 1002.3284399452239, 1074.9355038697547, 1132.671525257666, 1132.9660110196708, 1214.8724383939737, 14055.086419382707, 15380.692386152214, 15586.532404027897, 16871.578210544834, 17323.56691082733, 518945.0, 654314.7284263548, 655824.0, 660343.0, 669456.0, 51199.0, 59522.0, 60581.69709151426, 61058.694706526185, 61287.0, 1363.1071648070529, 1371.492547757336, 1391.8538553451945, 1412.7315809996069, 1413.8939579531577, 30748.385032299677, 31620.525692115098, 31766.841165794947, 31786.841065794524, 32317.676823231468, 52058.0, 52689.0, 52974.0, 52986.20520692116, 54035.729821350644, 591358.0, 600954.0, 601426.9857301371, 601667.0, 606167.0, 25976.74023259819, 26008.60987085233, 26259.606105908046, 26399.868000659873, 26458.338541535846, 47322.29016564685, 47437.0, 47806.0, 48675.0, 48795.75602122109, 38525.42211866768, 39714.60285397225, 40180.0, 40408.59591404048, 41350.37974430446, 39629.40555891606, 39819.800900996466, 40538.0, 40799.18401631891, 41239.1752164949, 38440.0, 39054.2189156221, 39134.0, 39444.0, 41309.58690413057, 30983.845080774452, 34991.82504087463, 35321.29357412889, 35494.97562431681, 35766.821165894005, 25474.617880732174, 25527.106551270615, 25660.871695641403, 25751.227463176136, 26158.215253542425], "value": 20001.47672946567, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.45025362463554, 372.5789857461069, 379.41001742290734, 382.1973854904702, 400.707483537018, 18830.058497075144, 19891.801081989175, 19930.903800290977, 20088.49778755532, 20118.597628047468, 19553.608927821435, 20474.07866646001, 20794.0, 20888.0, 21154.836483993375, 5767.336756273019, 5779.0, 6021.969890150565, 6070.059140833156, 6092.482139018189, 4136.172765446922, 4357.542458041908, 5895.410458954092, 6021.307549631782, 6030.065339872327, 6270.3729627037155, 6549.279579246303, 6631.93368066318, 6687.164104486939, 6696.698648560802, 6102.816915492543, 6633.8341541461605, 6677.799666010027, 6682.966585167067, 6693.062971184038, 5708.20085188074, 5761.135829625548, 5788.0739081746715, 5791.82624521265, 5811.041178205591, 25302.873485632637, 25434.618480722806, 25650.486990260277, 25653.871730641415, 25939.351516212057, 2165.8375621828427, 2235.3294011796397, 2253.0, 2392.928212153638, 2936.015152343703, 14666.266686665624, 15449.382024718998, 15732.764008539882, 15767.842321576867, 15833.0, 1622.9026258424533, 1773.632201011638, 1803.8275121171212, 1810.7102863541902, 1824.4891430399377, 87938.0, 116348.0, 117233.0, 126547.36726316309, 131326.68673313336, 10034.949825250973, 10259.384436933808, 11551.942240288745, 11580.710482238012, 11668.358240296866, 14491.78262326066, 14656.487022954145, 14657.04729192599, 14682.119072855663, 14700.0, 8218.260356567818, 8535.359848011423, 8556.401051926305, 8601.22588966996, 8675.262602678842, 6863.0, 6914.0, 7019.964900175569, 7700.5379677218425, 8506.0, 3402.6937575618313, 3907.5506316773367, 4234.978825105854, 4367.563243675607, 4636.513166117509, 1631.2496251724103, 1946.5231018400582, 1955.5795503966715, 3756.670864064243, 3831.3142217424243, 816.4652152839899, 907.2852309135739, 955.2739917662626, 982.5136557403988, 995.6465454763454, 19493.122809473607, 21244.57510849805, 21362.465938351666, 21713.67429488559, 21996.230131945304, 922.6355589542093, 935.7239614313794, 948.8434408322687, 980.3480685344309, 1000.7848312612823, 10801.189910756568, 11087.0, 11240.718982025515, 11283.605073822377, 11453.427328633536, 596308.0, 599942.0, 604723.0, 613569.0, 614423.062500936, 128540.0, 129936.0, 131513.0, 133614.0, 138706.0, 953.6948176583427, 957.9521023948774, 981.5092453773113, 983.2772911909741, 985.5959056786683, 19003.334883279018, 19143.712844307625, 19271.421857344303, 19314.71027934554, 19341.4197574073, 52168.69578260422, 57015.57461063506, 57193.71403143124, 58035.419645803, 58175.0, 69724.6513767428, 81301.18698812937, 82670.0, 83503.16496834953, 84079.15920840958, 7910.367170626451, 8069.677212911418, 8385.58072096405, 8408.495490270603, 8540.70107546233, 9195.77010574741, 12096.366990456176, 13083.345832708517, 13096.672583185496, 13100.803487947498, 10763.946180269362, 11121.221514494231, 11288.94355528217, 11296.717582060186, 11407.144464165054, 10575.524101415302, 10996.560137594406, 11144.888551114385, 11338.0, 11437.313761174357, 10928.781424371628, 11321.943390282995, 11684.357360345262, 11762.647120586396, 11928.045756339645, 7127.14474263071, 8133.959330203548, 8178.550179739934, 8360.749177524684, 8400.621972011397, 10742.83885741699, 10826.350418974887, 11413.486393112164, 11476.4261786912, 11510.884891151316], "value": 9798.585539000624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1529.4723320454443, 1561.9375224991, 1746.6768647800166, 1809.9819001809979, 1877.849772018238, 7825.0218722659665, 8087.433879628428, 8271.379646526511, 8849.690260840864, 8878.467291962479, 8336.333093352532, 8583.828323433527, 8586.184312490319, 8656.13438656134, 8697.565121743903, 2302.4704318006825, 2321.187584345474, 2322.6167682332393, 2329.1964272326104, 2339.2865176121363, 2276.362618466832, 2317.9304620861403, 2318.5826551220775, 2329.499157681098, 2330.3125577954543, 2303.424143964009, 2321.419645088728, 2323.674685544025, 2330.487292795582, 2342.508073304608, 2286.5084006938423, 2298.9425264368524, 2301.5627030864166, 2302.620067688821, 2304.089884495623, 2252.40311317501, 2277.601419751537, 2280.7149106361703, 2288.416453804286, 2292.33522278539, 7457.552546847152, 7471.887921681179, 8711.912880871238, 8833.646654133827, 8866.556672166365, 4580.656450766206, 5196.792128314863, 5243.9213411798855, 5336.759845806948, 5371.704556249405, 3344.130526063241, 3479.425894727367, 3579.588347340037, 3656.0, 3662.0661731258624, 1007.7682133109425, 1038.2576457832686, 1078.5062688176854, 1078.8112080385902, 1089.1232557790975, 9247.39891907024, 10568.418736969386, 10591.152707783358, 11366.318020918688, 11464.426778661034, 3992.401139829049, 4428.070105277863, 4592.7933243004145, 4676.158291507561, 4705.529447055267, 9674.22606191503, 9750.463724495079, 9797.412155270564, 9836.458994755358, 9859.309848310693, 4662.393888794503, 5302.257683924254, 5316.441773613792, 5326.201069839478, 5334.11987022137, 4306.763128027926, 4363.890902727394, 4645.721256724607, 4679.906401871944, 4765.5949244314625, 3781.810909454516, 3818.453526321844, 3902.1415288636454, 3924.4898163238595, 3944.171723938005, 1132.7791080739178, 1218.232513516479, 1280.3022352817736, 1290.4451086033096, 1301.73965206959, 739.4397820598533, 835.5613303015843, 904.7873749668822, 906.6373450619805, 928.7353104365359, 5648.124540696199, 5656.547476201894, 5804.042333015005, 5810.215620891126, 5943.31651860033, 911.3529394130242, 913.3971578757988, 956.8564715292623, 962.3456049886145, 974.5906719177821, 3725.925481490355, 3784.3188226119564, 3787.0721673189696, 3875.0312421894528, 3927.9803600981813, 7177.9641101795205, 9096.272298216127, 10195.796084078276, 10199.9490002551, 10233.283670143019, 10050.949745251228, 10196.898031019744, 10201.591936322464, 10224.488775561342, 10226.744331391626, 7656.081270247494, 8051.4766540174705, 8193.385496087698, 8211.753647390588, 8222.013358397031, 5715.542756579547, 5784.161296612052, 5805.912911306249, 5865.120231965239, 5919.437653422918, 9467.147956683932, 9611.327207095435, 9625.855612165684, 9718.368306060083, 9750.80498390014, 9433.339666223299, 9751.609935602497, 9826.65606703762, 9958.502074896081, 9981.951895051205, 5981.491573216325, 6834.316568343126, 7048.330408611174, 7340.412766978736, 7520.360769334668, 7920.089189743023, 8203.630836612487, 8289.58552072406, 8304.418690691835, 8364.749057528285, 7299.452541059548, 7401.925980740339, 7411.0736157980255, 7521.924780752122, 7544.321011108807, 7156.212816590067, 7268.9273107270365, 7270.636468176675, 7321.6705248265025, 7450.776476705708, 6827.385535301847, 6938.791836244921, 6947.270536593584, 6950.4787140965645, 6969.372756451741, 4807.759612019455, 4837.395325584302, 4956.3804524434445, 4988.5260900214425, 4996.925046124384, 4880.1215781159735, 4938.629602779878, 5003.4246061701915, 5061.4432412435335, 5149.897002060013], "value": 4477.340380829242, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.3458387795215, 298.3987265659695, 305.781366323079, 307.77532401347, 310.95024796032624, 4620.851304143573, 4879.292502587123, 4881.292212629167, 5587.547237718197, 5609.214709940612, 4513.526079761618, 4515.864524064284, 4879.53644403782, 5503.642263252896, 5515.255440515529, 3496.5454490916272, 3499.7900125992396, 4169.3537501687215, 4203.894902627443, 4213.241616509027, 4029.738067025634, 4224.66202703783, 4246.617804397603, 4260.275753121961, 4260.510041345238, 3651.269746050787, 3954.1498577805764, 4142.508696869125, 4164.66682665386, 4165.854195103172, 4036.2936486114813, 4089.447924530195, 4160.375943608453, 4191.874243772691, 4199.580041995776, 3638.435472746718, 3644.5444319460066, 3648.3615367310613, 3649.0, 3680.5215322008235, 5037.874053148664, 5387.171734839201, 5398.002738986561, 5426.8371948841595, 5455.0, 4724.4094488188975, 4729.62163026957, 4751.548602882721, 4756.881077973044, 4761.547652972962, 5677.243871326376, 5833.854153646151, 5857.092150716646, 5857.502112320458, 5914.9112763308585, 3893.532776066862, 3902.453656488094, 3907.238088572701, 3910.276598829197, 3914.6868250539887, 5486.655769336498, 5542.953643839979, 5734.111212762028, 6087.847803804941, 6139.662318572477, 3944.3491823849317, 3953.9604603954167, 3983.900402489903, 3984.7210695251056, 4014.698897582693, 3517.700995415418, 3790.7156963227867, 3954.6045395460224, 4039.7980100994832, 4104.384342348611, 4746.620270378361, 4747.667663263538, 4767.404074490689, 4770.189067858472, 4772.6420518461255, 4847.75761211938, 4857.684250523705, 5872.942870283305, 5896.852578685567, 5960.910586341121, 1173.184636677518, 1179.5517703272874, 1255.5480027190204, 1299.8505171905163, 1359.8572149924314, 804.955727434985, 819.8073452738602, 840.9873851892227, 841.2765022081005, 841.3059226138461, 3706.6293370663257, 4225.605550168437, 4280.245099509187, 4501.122281155143, 4561.908761824745, 4334.421019493397, 4576.98612610457, 4875.536824001714, 4982.427020892571, 4994.352992913761, 4455.262447645421, 4482.305242687388, 4557.931631025537, 4575.382323386367, 4729.858104256878, 2394.985314699076, 2532.544142054411, 2534.5817940040056, 2609.569421045544, 2651.403434227322, 4715.57559819611, 4870.902581948412, 4980.2778597103215, 5021.548060674557, 5241.633085684041, 4094.467719196485, 4755.381800366, 4878.999610159817, 5136.123770688427, 5263.36839579253, 3967.781772002568, 4337.414449049401, 4748.0, 5071.923921141112, 5106.106431374495, 4524.018863400187, 4787.8563643090765, 4991.825286114969, 4999.975000124976, 5040.924386134137, 4297.398364228948, 4482.0, 4770.592675160905, 5074.619403544675, 5086.796528138833, 4486.50648428666, 4775.296333111952, 4834.806607735652, 5171.715555644476, 5174.637775355689, 3127.499600063979, 3142.402943440739, 3423.691867731916, 3475.061733332037, 3490.5636795400574, 4620.973262513059, 4990.700557966534, 4998.725070121032, 5013.924791128209, 5021.397432308, 5105.642605017613, 5572.60991730575, 5813.476787089182, 5819.970900145472, 5895.730143894546, 4946.282788995503, 5819.447152520504, 5833.708314584169, 5845.678487683218, 5856.297244330707, 4725.740084295259, 5590.630295577609, 5699.401562835843, 5726.506830833105, 5789.2763404574425, 5118.899436621145, 5126.743662816919, 5789.536837052941, 5879.823605291848, 5936.851578710567, 4668.0860847052545, 5737.454941780524, 5788.27646544182, 5810.82567522975, 5825.3592104867585], "value": 3945.073749656462, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.3126183233179, 719.7804669575779, 752.53342927385, 790.5533373643894, 825.9091499935008, 15064.472743453982, 15434.151121688303, 15673.843261567381, 15704.842951570467, 15805.288762005708, 14221.928890355559, 14266.429342826275, 14387.424503019893, 14395.2082635455, 14441.0, 761.7486229544265, 856.2037305306047, 876.2201640539924, 884.2925659472428, 885.6723012485389, 854.4744981836158, 874.6501399440243, 875.6366108065146, 878.4685265414428, 880.0, 932.3939439364433, 932.822763674903, 933.3886304470583, 934.1452570897654, 935.4621092871593, 893.8837951066384, 923.8013827027221, 925.7407925780758, 927.0127314410132, 929.2705226397246, 671.5366397185926, 680.1158493957885, 692.1313751242209, 692.435664933083, 693.5457275484565, 13034.543790967366, 13221.73556528864, 13259.204447733167, 13894.957878159179, 14527.927360363235, 11802.0, 13158.86841131586, 13367.598972030855, 13711.245881476514, 13923.48776673615, 11213.551457941672, 11692.298462092302, 11694.415279236004, 11734.941325293405, 11893.167478276524, 3660.8352624131976, 3697.3714468540143, 3698.8335524901177, 3713.4801127842125, 3847.903802404934, 80181.59909200417, 80879.59560202161, 94690.0, 98289.5085524575, 100615.0, 9175.862362064574, 10687.62593309246, 10853.73727340452, 10962.616308429167, 11068.667939961813, 20554.0, 20757.37727868136, 20776.376708698765, 20788.480287992923, 20794.48013799637, 5374.946250537523, 7639.784462505922, 7826.217378262242, 7986.720464783704, 7991.560464174526, 4176.728512646669, 4332.068605249887, 4347.130573885235, 4355.825766969286, 4373.125374925028, 3425.9143521411665, 3537.080359106599, 3560.127768696686, 3582.964170358315, 3590.6588874056924, 645.4191227894838, 645.8826230621052, 657.5581943968463, 664.4319107163402, 665.55075324156, 544.3250369541819, 569.1945896556326, 591.3790519954117, 639.6545865232722, 662.2218892800939, 7675.848622706639, 7722.53664780115, 8104.797380065427, 8938.284937205008, 9118.908810911938, 455.68557695190214, 559.7732918168149, 571.8610713985364, 610.8167549735061, 634.7112064010864, 4295.312749959991, 4382.6055654991205, 4533.569310915524, 4546.431696037996, 4619.653525985565, 106701.46649266704, 109856.4507177475, 111623.0, 113023.0, 115679.0, 81046.0, 85466.71799923007, 86085.56957215299, 87246.56376718203, 102020.97979020263, 73260.53478930391, 73351.63324183345, 76868.84696729554, 88593.55703221442, 89023.66464503038, 9401.247900168108, 9541.034597554337, 9560.856587151338, 9578.425294482353, 9649.0, 54013.91972160614, 54125.0, 54995.72502137464, 55505.72247138739, 56864.14703779364, 67821.60891955481, 69467.65266173637, 71723.28276717375, 75196.62401687956, 76571.0, 12376.690582735504, 12574.434150463068, 12606.306653134166, 12929.935350323189, 13325.866741332462, 13419.127756695783, 14037.859621403655, 14245.430182792572, 14288.642783930485, 14354.641133971734, 13002.544910928073, 13033.804492932803, 13296.268705221306, 13418.798718019432, 13487.0, 12920.806187907001, 12922.0, 13125.60623181306, 13323.267220302589, 13791.310434478035, 10485.528151233366, 12684.492620295454, 13122.934385328012, 13147.342632868127, 13466.124701894345, 10592.8940710595, 10610.52252648648, 10683.459311276656, 10790.622328218475, 11033.889661103607, 9369.531523423666, 9633.22934165251, 9860.901390986286, 11122.499487522919, 11200.38397888124], "value": 7333.114801986131, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 119.0, 117.0, 141.0, 157.0, 117.0, 115.0, 116.0, 117.0], "value": 122.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 144.0, 184.0, 115.0, 115.0, 113.0, 118.0, 145.0, 130.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 207.0, 207.0, 200.0, 197.0, 197.0, 246.0, 209.0, 196.0, 196.0], "value": 206.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 85.0, 61.0, 61.0, 60.0, 59.0, 79.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 70.0, 86.0, 71.0, 70.0, 69.0, 114.0, 54.0, 78.0, 117.0], "value": 81.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 89.0, 85.0, 102.0, 86.0, 91.0, 87.0, 106.0, 131.0], "value": 95.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 99.0, 96.0, 134.0, 92.0, 134.0, 95.0], "value": 103.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 92.0, 86.0, 84.0, 117.0, 85.0, 77.0, 140.0, 134.0, 90.0], "value": 100.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 55.0, 59.0, 58.0, 61.0, 61.0, 90.0, 88.0, 89.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 77.0, 77.0, 79.0, 87.0, 61.0, 69.0, 81.0, 104.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 114.0, 113.0, 110.0, 111.0, 93.0, 90.0, 94.0, 94.0], "value": 99.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 153.0, 163.0, 161.0, 165.0, 163.0, 146.0, 154.0, 194.0, 149.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 237.0, 174.0, 173.0, 173.0, 174.0, 176.0, 174.0, 177.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 72.0, 68.0, 72.0, 76.0, 78.0, 84.0, 71.0, 62.0], "value": 72.0, "unit": "score"}]}]} 04:05:48 INFO - Return code: 0 04:05:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:05:48 ERROR - # TBPL SUCCESS # 04:05:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:05:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:05:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:05:48 INFO - 2016-10-25 04:05:48.817 screenresolution[1676:10780] starting screenresolution argv=screenresolution get 04:05:48 INFO - 2016-10-25 04:05:48.819 screenresolution[1676:10780] Display 0: 1600x1200x32@60 04:05:48 INFO - 2016-10-25 04:05:48.825 screenresolution[1677:10783] starting screenresolution argv=screenresolution list 04:05:48 INFO - Available Modes on Display 0 04:05:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:05:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:05:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:05:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:05:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:05:49 INFO - Intel Iris: 04:05:49 INFO - Chipset Model: Intel Iris 04:05:49 INFO - Type: GPU 04:05:49 INFO - Bus: Built-In 04:05:49 INFO - VRAM (Dynamic, Max): 1536 MB 04:05:49 INFO - Vendor: Intel (0x8086) 04:05:49 INFO - Device ID: 0x0a2e 04:05:49 INFO - Revision ID: 0x0009 04:05:49 INFO - Displays: 04:05:49 INFO - Display: 04:05:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:05:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:05:49 INFO - Display Serial Number: 1600x1200 60 04:05:49 INFO - Main Display: Yes 04:05:49 INFO - Mirror: Off 04:05:49 INFO - Online: Yes 04:05:49 INFO - Rotation: Supported 04:05:49 INFO - Return code: 0 04:05:49 INFO - Running post-action listener: _resource_record_post_action 04:05:49 INFO - [mozharness: 2016-10-25 11:05:49.065126Z] Finished run-tests step (success) 04:05:49 INFO - Running post-run listener: _resource_record_post_run 04:05:49 INFO - Total resource usage - Wall time: 1212s; CPU: 55.0%; Read bytes: 38611456; Write bytes: 709538304; Read time: 245; Write time: 2085 04:05:49 INFO - TinderboxPrint: CPU usage
54.6% 04:05:49 INFO - TinderboxPrint: I/O read bytes / time
38,611,456 / 245 04:05:49 INFO - TinderboxPrint: I/O write bytes / time
709,538,304 / 2,085 04:05:49 INFO - TinderboxPrint: CPU idle
2,202.3 (45.4%) 04:05:49 INFO - TinderboxPrint: CPU system
976.9 (20.1%) 04:05:49 INFO - TinderboxPrint: CPU user
1,670.6 (34.4%) 04:05:49 INFO - TinderboxPrint: Swap in / out
443,338,752 / 0 04:05:49 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 397515264; Write bytes: 390993920; Read time: 29867; Write time: 862 04:05:49 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 36555264; Write bytes: 302254592; Read time: 226; Write time: 1180 04:05:49 INFO - Running post-run listener: _upload_blobber_files 04:05:49 INFO - Blob upload gear active. 04:05:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:05:49 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 04:05:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:05:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:05:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:05:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:05:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:51 INFO - (blobuploader) - INFO - Done attempting. 04:05:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:05:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:05:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:51 INFO - (blobuploader) - INFO - Done attempting. 04:05:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:05:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:05:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:54 INFO - (blobuploader) - INFO - Done attempting. 04:05:54 INFO - (blobuploader) - INFO - Iteration through files over. 04:05:54 INFO - Return code: 0 04:05:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:05:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:05:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f562e46a3d47d539f0a6f445a1515b9526adde32fcba7a923859c881f6301c0c8311e480216087cd6dce8ddacae7f2d0e99aabc5c40f18619b7c1b3205aaa5d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5913ebc7fdb979fddc23f6212242c275edea27d020069ad90665a431f985a32aff9b7fd20ce056287d259abcc64dca2542541a6e60009d2203dbeed0e7ff3c95", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/408a96db5e3441fe679948c26bd37ba15ef6613b26daa2071e105c4920a4d3118e620d12d340a22ec5172267295ca92eff41498d8162f0706c1b2ee9e2d41092"} 04:05:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:05:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:05:54 INFO - Contents: 04:05:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f562e46a3d47d539f0a6f445a1515b9526adde32fcba7a923859c881f6301c0c8311e480216087cd6dce8ddacae7f2d0e99aabc5c40f18619b7c1b3205aaa5d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5913ebc7fdb979fddc23f6212242c275edea27d020069ad90665a431f985a32aff9b7fd20ce056287d259abcc64dca2542541a6e60009d2203dbeed0e7ff3c95", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/408a96db5e3441fe679948c26bd37ba15ef6613b26daa2071e105c4920a4d3118e620d12d340a22ec5172267295ca92eff41498d8162f0706c1b2ee9e2d41092"} 04:05:54 INFO - Running post-run listener: copy_logs_to_upload_dir 04:05:54 INFO - Copying logs to upload dir... 04:05:54 INFO - mkdir: /builds/slave/test/build/upload/logs 04:05:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.893917 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-25 04:05:54.765246) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 04:05:54.768411) ========= 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.OXTPuT8myF/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.h7CwhYlBxE/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f562e46a3d47d539f0a6f445a1515b9526adde32fcba7a923859c881f6301c0c8311e480216087cd6dce8ddacae7f2d0e99aabc5c40f18619b7c1b3205aaa5d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5913ebc7fdb979fddc23f6212242c275edea27d020069ad90665a431f985a32aff9b7fd20ce056287d259abcc64dca2542541a6e60009d2203dbeed0e7ff3c95", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/408a96db5e3441fe679948c26bd37ba15ef6613b26daa2071e105c4920a4d3118e620d12d340a22ec5172267295ca92eff41498d8162f0706c1b2ee9e2d41092"} build_url:https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/GnW23CgpQTWt8RyUK8FJ-w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f562e46a3d47d539f0a6f445a1515b9526adde32fcba7a923859c881f6301c0c8311e480216087cd6dce8ddacae7f2d0e99aabc5c40f18619b7c1b3205aaa5d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5913ebc7fdb979fddc23f6212242c275edea27d020069ad90665a431f985a32aff9b7fd20ce056287d259abcc64dca2542541a6e60009d2203dbeed0e7ff3c95", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/408a96db5e3441fe679948c26bd37ba15ef6613b26daa2071e105c4920a4d3118e620d12d340a22ec5172267295ca92eff41498d8162f0706c1b2ee9e2d41092"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 04:05:54.800176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 04:05:54.800521) ========= 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.OXTPuT8myF/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.h7CwhYlBxE/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.005216 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 04:05:54.848459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 04:05:54.848753) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 04:05:54.849068) ========= ========= Total master_lag: 0.17 =========