builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0159 starttime: 1484855217.93 results: success (0) buildid: 20170119091728 builduid: d31c299ea7324cf9bb71ce25658afefc revision: 998f11970867282c85b89385a08bc172ce5b02d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 11:46:57.930173) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 11:46:57.931154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 11:46:57.931899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 11:46:57.957934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:46:57.958602) ========= 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.7es3Mw1mNS/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.x768rAJtia/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-19 11:46:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.45M=0.001s 2017-01-19 11:46:58 (8.45 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144696 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:46:58.133334) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:46:58.134154) ========= 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.7es3Mw1mNS/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.x768rAJtia/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.021242 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:46:58.186987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 11:46:58.187769) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 998f11970867282c85b89385a08bc172ce5b02d2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 998f11970867282c85b89385a08bc172ce5b02d2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7es3Mw1mNS/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.x768rAJtia/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-19 11:46:58,283 truncating revision to first 12 chars 2017-01-19 11:46:58,283 Setting DEBUG logging. 2017-01-19 11:46:58,283 attempt 1/10 2017-01-19 11:46:58,283 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/998f11970867?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 11:46:59,461 unpacking tar archive at: mozilla-aurora-998f11970867/testing/mozharness/ program finished with exit code 0 elapsedTime=1.431987 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 11:46:59.647964) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 11:46:59.648330) ========= script_repo_revision: 998f11970867282c85b89385a08bc172ce5b02d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 11:46:59.648798) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 11:46:59.649101) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 11:46:59.669120) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-01-19 11:46:59.669464) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7es3Mw1mNS/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.x768rAJtia/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 11:46:59 INFO - MultiFileLogger online at 20170119 11:46:59 in /builds/slave/test 11:46:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:46:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:46:59 INFO - {'append_to_log': False, 11:46:59 INFO - 'base_work_dir': '/builds/slave/test', 11:46:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:46:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:46:59 INFO - 'branch': 'Mozilla-Aurora', 11:46:59 INFO - 'buildbot_json_path': 'buildprops.json', 11:46:59 INFO - 'config_files': ('talos/mac_config.py',), 11:46:59 INFO - 'default_actions': ('clobber', 11:46:59 INFO - 'read-buildbot-config', 11:46:59 INFO - 'download-and-extract', 11:46:59 INFO - 'populate-webroot', 11:46:59 INFO - 'create-virtualenv', 11:46:59 INFO - 'install', 11:46:59 INFO - 'run-tests'), 11:46:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:46:59 INFO - 'download_minidump_stackwalk': True, 11:46:59 INFO - 'download_symbols': 'ondemand', 11:46:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:46:59 INFO - 'tooltool.py': '/tools/tooltool.py', 11:46:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:46:59 INFO - '/tools/misc-python/virtualenv.py')}, 11:46:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:46:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:46:59 INFO - 'installer_path': 'installer.exe', 11:46:59 INFO - 'log_level': 'info', 11:46:59 INFO - 'log_name': 'talos', 11:46:59 INFO - 'log_to_console': True, 11:46:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:46:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:46:59 INFO - 'opt_config_files': (), 11:46:59 INFO - 'pip_index': False, 11:46:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:46:59 INFO - 'cmd': ('bash', 11:46:59 INFO - '-c', 11:46:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:46:59 INFO - 'enabled': True, 11:46:59 INFO - 'halt_on_failure': False, 11:46:59 INFO - 'name': 'check_screen_resolution'},), 11:46:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:46:59 INFO - 'cmd': ('bash', 11:46:59 INFO - '-c', 11:46:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:46:59 INFO - 'enabled': True, 11:46:59 INFO - 'halt_on_failure': False, 11:46:59 INFO - 'name': 'check_screen_resolution'},), 11:46:59 INFO - 'run_cmd_checks_enabled': True, 11:46:59 INFO - 'sps_profile': False, 11:46:59 INFO - 'sps_profile_interval': 0, 11:46:59 INFO - 'suite': 'dromaeojs-e10s', 11:46:59 INFO - 'system_bits': '32', 11:46:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:46:59 INFO - 'title': 't-yosemite-r7-0159', 11:46:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:46:59 INFO - 'use_talos_json': True, 11:46:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:46:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:46:59 INFO - 'work_dir': 'build'} 11:46:59 INFO - [mozharness: 2017-01-19 19:46:59.886490Z] Running clobber step. 11:46:59 INFO - Running pre-action listener: _resource_record_pre_action 11:46:59 INFO - Running main action method: clobber 11:46:59 INFO - rmtree: /builds/slave/test/build 11:46:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:47:00 INFO - Running post-action listener: _resource_record_post_action 11:47:00 INFO - [mozharness: 2017-01-19 19:47:00.129722Z] Finished clobber step (success) 11:47:00 INFO - [mozharness: 2017-01-19 19:47:00.129854Z] Running read-buildbot-config step. 11:47:00 INFO - Running pre-action listener: _resource_record_pre_action 11:47:00 INFO - Running main action method: read_buildbot_config 11:47:00 INFO - Using buildbot properties: 11:47:00 INFO - { 11:47:00 INFO - "project": "", 11:47:00 INFO - "product": "firefox", 11:47:00 INFO - "script_repo_revision": "production", 11:47:00 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 11:47:00 INFO - "repository": "", 11:47:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 11:47:00 INFO - "buildid": "20170119091728", 11:47:00 INFO - "pgo_build": "False", 11:47:00 INFO - "basedir": "/builds/slave/test", 11:47:00 INFO - "buildnumber": 73, 11:47:00 INFO - "slavename": "t-yosemite-r7-0159", 11:47:00 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:47:00 INFO - "platform": "yosemite_r7", 11:47:00 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:47:00 INFO - "branch": "mozilla-aurora", 11:47:00 INFO - "repo_path": "releases/mozilla-aurora", 11:47:00 INFO - "revision": "998f11970867282c85b89385a08bc172ce5b02d2", 11:47:00 INFO - "stage_platform": "macosx64", 11:47:00 INFO - "builduid": "d31c299ea7324cf9bb71ce25658afefc", 11:47:00 INFO - "slavebuilddir": "test" 11:47:00 INFO - } 11:47:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 11:47:00 INFO - Running post-action listener: _resource_record_post_action 11:47:00 INFO - [mozharness: 2017-01-19 19:47:00.133184Z] Finished read-buildbot-config step (success) 11:47:00 INFO - [mozharness: 2017-01-19 19:47:00.133283Z] Running download-and-extract step. 11:47:00 INFO - Running pre-action listener: _resource_record_pre_action 11:47:00 INFO - Running main action method: download_and_extract 11:47:00 INFO - mkdir: /builds/slave/test/build/tests 11:47: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')]} 11:47:00 INFO - trying https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 11:47:00 INFO - Downloading https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 11:47:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 11:47:01 INFO - Downloaded 1199 bytes. 11:47:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 11:47:01 INFO - Using the following test package requirements: 11:47:01 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 11:47:01 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:47:01 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 11:47:01 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:47:01 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 11:47:01 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:47:01 INFO - u'jsshell-mac.zip'], 11:47:01 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:47:01 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 11:47:01 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 11:47:01 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:47:01 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 11:47:01 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:47:01 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 11:47:01 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:47:01 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 11:47:01 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:47:01 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 11:47:01 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:47:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 11:47:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:47:01 INFO - Fetch https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 11:47:02 INFO - Http code: 200 11:47:02 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 11:47:02 INFO - x-amz-cf-id: wkS94A3s0_KH6JTa79DO0En3ghc-XLZ_uwuKY4YB5q-a-TJPDA6XuA== 11:47:02 INFO - x-amz-version-id: W4RJeub1r15BbJlxj4msxzG3hwFA63t3 11:47:02 INFO - Expected file size: 16276182 11:47:02 INFO - Obtained file size: 16276182 11:47:09 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:47:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 11:47:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:47:09 INFO - Fetch https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 11:47:09 INFO - Http code: 200 11:47:09 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 11:47:09 INFO - x-amz-cf-id: x4BpEQBSM9240lRCIjG6CACiDAtJY2MIzeE2gXmaCx1WG76b3zA5LA== 11:47:09 INFO - x-amz-version-id: W4RJeub1r15BbJlxj4msxzG3hwFA63t3 11:47:09 INFO - Expected file size: 16276182 11:47:09 INFO - Obtained file size: 16276182 11:47:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 11:47:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:47:16 INFO - Fetch https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 11:47:17 INFO - Http code: 200 11:47:17 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 11:47:17 INFO - x-amz-cf-id: FXHdaW23BXdAk6CVSPt4aYxyKLEAUi_slfn5rmg9qlw_xwH5RpYL9g== 11:47:17 INFO - x-amz-version-id: EIz0iplTzpMekuwUPvCdaLtWA83w3k.B 11:47:17 INFO - Expected file size: 14409038 11:47:17 INFO - Obtained file size: 14409038 11:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:17 INFO - trying https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:47:17 INFO - Downloading https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 11:47:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 11:47:20 INFO - Downloaded 109968758 bytes. 11:47:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:47:20 INFO - mkdir: /builds/slave/test/properties 11:47:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:47:20 INFO - Writing to file /builds/slave/test/properties/build_url 11:47:20 INFO - Contents: 11:47:20 INFO - build_url:https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:47:21 INFO - Running post-action listener: _resource_record_post_action 11:47:21 INFO - Running post-action listener: set_extra_try_arguments 11:47:21 INFO - [mozharness: 2017-01-19 19:47:21.687899Z] Finished download-and-extract step (success) 11:47:21 INFO - [mozharness: 2017-01-19 19:47:21.688026Z] Running populate-webroot step. 11:47:21 INFO - Running pre-action listener: _resource_record_pre_action 11:47:21 INFO - Running main action method: populate_webroot 11:47:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:47:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:47:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:47:21 INFO - '--tppagecycles', 11:47:21 INFO - '7'], 11:47:21 INFO - 'tests': ['tsvgm']}}, 11:47:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:47:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:47:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:47:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:47:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:47:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:47:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:21 INFO - 'talos_options': ['--disable-e10s'], 11:47:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:21 INFO - 'talos_options': ['--disable-e10s'], 11:47:21 INFO - 'tests': ['damp', 'tps']}, 11:47:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:21 INFO - 'tests': ['damp', 'tps']}, 11:47:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:47:21 INFO - 'tests': ['dromaeo_dom']}, 11:47:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:47:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:47:21 INFO - 'tests': ['basic_compositor_video']}, 11:47:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:47:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:47:21 INFO - 'tests': ['a11yr', 11:47:21 INFO - 'ts_paint', 11:47:21 INFO - 'tpaint', 11:47:21 INFO - 'sessionrestore', 11:47:21 INFO - 'sessionrestore_no_auto_restore', 11:47:21 INFO - 'tabpaint']}, 11:47:21 INFO - 'other-e10s': {'tests': ['a11yr', 11:47:21 INFO - 'ts_paint', 11:47:21 INFO - 'tpaint', 11:47:21 INFO - 'sessionrestore', 11:47:21 INFO - 'sessionrestore_no_auto_restore', 11:47:21 INFO - 'tabpaint']}, 11:47:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:47:21 INFO - 'ts_paint', 11:47:21 INFO - 'tpaint', 11:47:21 INFO - 'sessionrestore', 11:47:21 INFO - 'sessionrestore_no_auto_restore', 11:47:21 INFO - 'tabpaint']}, 11:47:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:47:21 INFO - 'ts_paint', 11:47:21 INFO - 'tpaint', 11:47:21 INFO - 'sessionrestore', 11:47:21 INFO - 'sessionrestore_no_auto_restore', 11:47:21 INFO - 'tabpaint']}, 11:47:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:47:21 INFO - 'tests': ['a11yr', 11:47:21 INFO - 'ts_paint', 11:47:21 INFO - 'tpaint', 11:47:21 INFO - 'sessionrestore', 11:47:21 INFO - 'sessionrestore_no_auto_restore', 11:47:21 INFO - 'tabpaint']}, 11:47:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:47:21 INFO - 'tests': ['a11yr', 11:47:21 INFO - 'ts_paint', 11:47:21 INFO - 'tpaint', 11:47:21 INFO - 'sessionrestore', 11:47:21 INFO - 'sessionrestore_no_auto_restore', 11:47:21 INFO - 'tabpaint']}, 11:47:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:47:21 INFO - 'tests': ['tsvgx', 11:47:21 INFO - 'tsvgr_opacity', 11:47:21 INFO - 'tart', 11:47:21 INFO - 'tscrollx', 11:47:21 INFO - 'cart']}, 11:47:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:47:21 INFO - 'tsvgr_opacity', 11:47:21 INFO - 'tart', 11:47:21 INFO - 'tscrollx', 11:47:21 INFO - 'cart']}, 11:47:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:21 INFO - 'talos_options': ['--disable-e10s'], 11:47:21 INFO - 'tests': ['tp5o']}, 11:47:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:21 INFO - 'tests': ['tp5o']}, 11:47:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:21 INFO - 'talos_options': ['--disable-e10s', 11:47:21 INFO - '--xperf_path', 11:47:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:21 INFO - 'tests': ['tp5n']}, 11:47:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:21 INFO - 'talos_options': ['--xperf_path', 11:47:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:21 INFO - 'tests': ['tp5n']}}, 11:47:21 INFO - 'talos.zip': {'path': '', 11:47:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:47:21 INFO - Running post-action listener: _resource_record_post_action 11:47:21 INFO - [mozharness: 2017-01-19 19:47:21.706868Z] Finished populate-webroot step (success) 11:47:21 INFO - [mozharness: 2017-01-19 19:47:21.706997Z] Running create-virtualenv step. 11:47:21 INFO - Running pre-action listener: _resource_record_pre_action 11:47:21 INFO - Running main action method: create_virtualenv 11:47:21 INFO - Creating virtualenv /builds/slave/test/build/venv 11:47:21 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 11:47:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:47:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:47:21 INFO - Using real prefix '/tools/python27' 11:47:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:47:22 INFO - Installing distribute.............................................................................................................................................................................................done. 11:47:25 INFO - Installing pip.................done. 11:47:25 INFO - Return code: 0 11:47:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:47:25 INFO - Reading from file tmpfile_stdout 11:47:25 INFO - Output received: 11:47:25 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) 11:47:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:47:25 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')]} 11:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:25 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')]} 11:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:25 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 0x106403490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106379570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bad85680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106217d30>, '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 0x10607ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10620fb20>, '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.7es3Mw1mNS/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.x768rAJtia/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 11:47:25 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 11:47:25 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 11:47:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7es3Mw1mNS/Render', 11:47:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:25 INFO - 'HOME': '/Users/cltbld', 11:47:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:25 INFO - 'LOGNAME': 'cltbld', 11:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:25 INFO - 'MOZ_NO_REMOTE': '1', 11:47:25 INFO - 'NO_EM_RESTART': '1', 11:47:25 INFO - 'PAGER': '/bin/cat', 11:47:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:25 INFO - 'PWD': '/builds/slave/test', 11:47:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:25 INFO - 'SHELL': '/bin/bash', 11:47:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x768rAJtia/Listeners', 11:47:25 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 11:47:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:25 INFO - 'USER': 'cltbld', 11:47:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:25 INFO - 'XPC_FLAGS': '0x0', 11:47:25 INFO - 'XPC_SERVICE_NAME': '0', 11:47:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:25 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 11:47:25 INFO - Cleaning up... 11:47:25 INFO - Return code: 0 11:47:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:47:25 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')]} 11:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:25 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')]} 11:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:25 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 0x106403490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106379570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bad85680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106217d30>, '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 0x10607ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10620fb20>, '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.7es3Mw1mNS/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.x768rAJtia/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 11:47:25 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 11:47:25 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 11:47:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7es3Mw1mNS/Render', 11:47:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:25 INFO - 'HOME': '/Users/cltbld', 11:47:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:25 INFO - 'LOGNAME': 'cltbld', 11:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:25 INFO - 'MOZ_NO_REMOTE': '1', 11:47:25 INFO - 'NO_EM_RESTART': '1', 11:47:25 INFO - 'PAGER': '/bin/cat', 11:47:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:25 INFO - 'PWD': '/builds/slave/test', 11:47:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:25 INFO - 'SHELL': '/bin/bash', 11:47:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x768rAJtia/Listeners', 11:47:25 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 11:47:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:25 INFO - 'USER': 'cltbld', 11:47:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:25 INFO - 'XPC_FLAGS': '0x0', 11:47:25 INFO - 'XPC_SERVICE_NAME': '0', 11:47:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:26 INFO - Downloading/unpacking psutil>=3.1.1 11:47:26 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 11:47:26 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 11:47:26 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 11:47:26 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 11:47:26 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 11:47:26 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 11:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:47:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:29 INFO - Installing collected packages: psutil 11:47:29 INFO - Running setup.py install for psutil 11:47:29 INFO - building 'psutil._psutil_osx' extension 11:47:29 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 11:47:30 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 11:47:30 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 11:47:30 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 11:47:30 INFO - building 'psutil._psutil_posix' extension 11:47:30 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 11:47:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:47:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:47:30 INFO - ^ 11:47:30 INFO - 1 warning generated. 11:47:30 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 11:47:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:30 INFO - Successfully installed psutil 11:47:30 INFO - Cleaning up... 11:47:30 INFO - Return code: 0 11:47:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:47:30 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')]} 11:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:30 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')]} 11:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:30 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 0x106403490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106379570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bad85680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106217d30>, '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 0x10607ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10620fb20>, '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.7es3Mw1mNS/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.x768rAJtia/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 11:47:30 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 11:47:30 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 11:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7es3Mw1mNS/Render', 11:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:30 INFO - 'HOME': '/Users/cltbld', 11:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:30 INFO - 'LOGNAME': 'cltbld', 11:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:30 INFO - 'MOZ_NO_REMOTE': '1', 11:47:30 INFO - 'NO_EM_RESTART': '1', 11:47:30 INFO - 'PAGER': '/bin/cat', 11:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:30 INFO - 'PWD': '/builds/slave/test', 11:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:30 INFO - 'SHELL': '/bin/bash', 11:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x768rAJtia/Listeners', 11:47:30 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 11:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:30 INFO - 'USER': 'cltbld', 11:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:30 INFO - 'XPC_FLAGS': '0x0', 11:47:30 INFO - 'XPC_SERVICE_NAME': '0', 11:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:47:30 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 11:47:30 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 11:47:30 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 11:47:30 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 11:47:30 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 11:47:30 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 11:47:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:47:33 INFO - Installing collected packages: mozsystemmonitor 11:47:33 INFO - Running setup.py install for mozsystemmonitor 11:47:33 INFO - Successfully installed mozsystemmonitor 11:47:33 INFO - Cleaning up... 11:47:33 INFO - Return code: 0 11:47:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:47:33 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')]} 11:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:33 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')]} 11:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:33 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 0x106403490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106379570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bad85680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106217d30>, '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 0x10607ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10620fb20>, '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.7es3Mw1mNS/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.x768rAJtia/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 11:47:33 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 11:47:33 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 11:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7es3Mw1mNS/Render', 11:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:33 INFO - 'HOME': '/Users/cltbld', 11:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:33 INFO - 'LOGNAME': 'cltbld', 11:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:33 INFO - 'MOZ_NO_REMOTE': '1', 11:47:33 INFO - 'NO_EM_RESTART': '1', 11:47:33 INFO - 'PAGER': '/bin/cat', 11:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:33 INFO - 'PWD': '/builds/slave/test', 11:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:33 INFO - 'SHELL': '/bin/bash', 11:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x768rAJtia/Listeners', 11:47:33 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 11:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:33 INFO - 'USER': 'cltbld', 11:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:33 INFO - 'XPC_FLAGS': '0x0', 11:47:33 INFO - 'XPC_SERVICE_NAME': '0', 11:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:34 INFO - Downloading/unpacking jsonschema==2.5.1 11:47:34 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 11:47:34 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 11:47:34 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 11:47:34 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 11:47:34 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 11:47:34 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 11:47:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:47:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 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 11:47:37 INFO - Downloading functools32-3.2.3-2.tar.gz 11:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:47:37 INFO - warning: no files found matching '*.txt' 11:47:37 INFO - no previously-included directories found matching 'build' 11:47:37 INFO - no previously-included directories found matching 'dist' 11:47:37 INFO - no previously-included directories found matching '.git*' 11:47:37 INFO - Installing collected packages: jsonschema, functools32 11:47:37 INFO - Running setup.py install for functools32 11:47:37 INFO - warning: no files found matching '*.txt' 11:47:37 INFO - no previously-included directories found matching 'build' 11:47:37 INFO - no previously-included directories found matching 'dist' 11:47:37 INFO - no previously-included directories found matching '.git*' 11:47:37 INFO - Successfully installed jsonschema functools32 11:47:37 INFO - Cleaning up... 11:47:37 INFO - Return code: 0 11:47:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:37 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 0x106403490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106379570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bad85680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106217d30>, '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 0x10607ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10620fb20>, '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.7es3Mw1mNS/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.x768rAJtia/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 11:47:37 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 11:47:37 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 11:47:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7es3Mw1mNS/Render', 11:47:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:37 INFO - 'HOME': '/Users/cltbld', 11:47:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:37 INFO - 'LOGNAME': 'cltbld', 11:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:37 INFO - 'MOZ_NO_REMOTE': '1', 11:47:37 INFO - 'NO_EM_RESTART': '1', 11:47:37 INFO - 'PAGER': '/bin/cat', 11:47:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:37 INFO - 'PWD': '/builds/slave/test', 11:47:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:37 INFO - 'SHELL': '/bin/bash', 11:47:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x768rAJtia/Listeners', 11:47:37 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 11:47:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:37 INFO - 'USER': 'cltbld', 11:47:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:37 INFO - 'XPC_FLAGS': '0x0', 11:47:37 INFO - 'XPC_SERVICE_NAME': '0', 11:47:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:47:37 INFO - Cleaning up... 11:47:37 INFO - Return code: 0 11:47:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:37 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 0x106403490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106379570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bad85680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106217d30>, '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 0x10607ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10620fb20>, '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.7es3Mw1mNS/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.x768rAJtia/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 11:47:37 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 11:47:37 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 11:47:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7es3Mw1mNS/Render', 11:47:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:37 INFO - 'HOME': '/Users/cltbld', 11:47:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:37 INFO - 'LOGNAME': 'cltbld', 11:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:37 INFO - 'MOZ_NO_REMOTE': '1', 11:47:37 INFO - 'NO_EM_RESTART': '1', 11:47:37 INFO - 'PAGER': '/bin/cat', 11:47:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:37 INFO - 'PWD': '/builds/slave/test', 11:47:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:37 INFO - 'SHELL': '/bin/bash', 11:47:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x768rAJtia/Listeners', 11:47:37 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 11:47:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:37 INFO - 'USER': 'cltbld', 11:47:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:37 INFO - 'XPC_FLAGS': '0x0', 11:47:37 INFO - 'XPC_SERVICE_NAME': '0', 11:47:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:38 INFO - Downloading/unpacking blobuploader==1.2.4 11:47:38 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 11:47:38 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 11:47:38 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 11:47:38 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 11:47:38 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 11:47:38 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 11:47:40 INFO - Downloading blobuploader-1.2.4.tar.gz 11:47:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:47:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:47:40 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 11:47:40 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 11:47:40 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 11:47:40 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 11:47:40 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 11:47:40 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 11:47:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:47:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:47:41 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 11:47:41 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 11:47:41 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 11:47:41 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 11:47:41 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 11:47:41 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 11:47:41 INFO - Downloading docopt-0.6.1.tar.gz 11:47:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:47:41 INFO - Installing collected packages: blobuploader, requests, docopt 11:47:41 INFO - Running setup.py install for blobuploader 11:47:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:47:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:47:42 INFO - Running setup.py install for requests 11:47:42 INFO - Running setup.py install for docopt 11:47:42 INFO - Successfully installed blobuploader requests docopt 11:47:42 INFO - Cleaning up... 11:47:42 INFO - Return code: 0 11:47:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47: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')]} 11:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47: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')]} 11:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:42 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 0x106403490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106379570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bad85680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106217d30>, '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 0x10607ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10620fb20>, '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.7es3Mw1mNS/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.x768rAJtia/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 11:47:42 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 11:47:42 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 11:47:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7es3Mw1mNS/Render', 11:47:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:42 INFO - 'HOME': '/Users/cltbld', 11:47:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:42 INFO - 'LOGNAME': 'cltbld', 11:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:42 INFO - 'MOZ_NO_REMOTE': '1', 11:47:42 INFO - 'NO_EM_RESTART': '1', 11:47:42 INFO - 'PAGER': '/bin/cat', 11:47:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:42 INFO - 'PWD': '/builds/slave/test', 11:47:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:42 INFO - 'SHELL': '/bin/bash', 11:47:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x768rAJtia/Listeners', 11:47:42 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 11:47:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:42 INFO - 'USER': 'cltbld', 11:47:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:42 INFO - 'XPC_FLAGS': '0x0', 11:47:42 INFO - 'XPC_SERVICE_NAME': '0', 11:47:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-DCMYFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-VJwqWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-o1ZuY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-rDA9t2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-aEmy4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-A6hcsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-cdk6J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-40b4rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Ei6Bwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-vnQSgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-KL8tv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-NIB7uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-851Jwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-L4jXnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Cg_u2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Y6nmBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-wDMxGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:47:44 INFO - Running setup.py install for manifestparser 11:47:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:47:45 INFO - Running setup.py install for mozcrash 11:47:45 INFO - Running setup.py install for mozdebug 11:47:45 INFO - Running setup.py install for mozdevice 11:47:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:47:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:47:45 INFO - Running setup.py install for mozfile 11:47:45 INFO - Running setup.py install for mozhttpd 11:47:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:47:45 INFO - Running setup.py install for mozinfo 11:47:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:47:45 INFO - Running setup.py install for mozInstall 11:47:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:47:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:47:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:47:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:47:46 INFO - Running setup.py install for mozleak 11:47:46 INFO - Running setup.py install for mozlog 11:47:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:47:46 INFO - Running setup.py install for moznetwork 11:47:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:47:46 INFO - Running setup.py install for mozprocess 11:47:46 INFO - Running setup.py install for mozprofile 11:47:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:47:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:47:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:47:46 INFO - Running setup.py install for mozrunner 11:47:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:47:47 INFO - Running setup.py install for mozscreenshot 11:47:47 INFO - Running setup.py install for moztest 11:47:47 INFO - Running setup.py install for mozversion 11:47:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:47:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:47:47 INFO - Cleaning up... 11:47:47 INFO - Return code: 0 11:47:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:47 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 0x106403490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106379570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bad85680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106217d30>, '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 0x10607ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10620fb20>, '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.7es3Mw1mNS/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.x768rAJtia/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 11:47:47 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 11:47:47 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 11:47:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7es3Mw1mNS/Render', 11:47:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:47 INFO - 'HOME': '/Users/cltbld', 11:47:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:47 INFO - 'LOGNAME': 'cltbld', 11:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:47 INFO - 'MOZ_NO_REMOTE': '1', 11:47:47 INFO - 'NO_EM_RESTART': '1', 11:47:47 INFO - 'PAGER': '/bin/cat', 11:47:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:47 INFO - 'PWD': '/builds/slave/test', 11:47:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:47 INFO - 'SHELL': '/bin/bash', 11:47:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x768rAJtia/Listeners', 11:47:47 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 11:47:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:47 INFO - 'USER': 'cltbld', 11:47:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:47 INFO - 'XPC_FLAGS': '0x0', 11:47:47 INFO - 'XPC_SERVICE_NAME': '0', 11:47:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-SkHoZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:47 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)) 11:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-CHXi6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:47 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-kz2lkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:48 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)) 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-UUXSAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:48 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)) 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-jtQa8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:48 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)) 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-R4IpsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:48 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)) 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-p64aP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:48 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)) 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-2eedCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:48 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)) 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-IKW12V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:48 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)) 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-klGaBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:48 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)) 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-jiPDKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:48 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)) 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:48 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-HF1ik9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:49 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)) 11:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-feGJq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:49 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)) 11:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-2ZNhiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-cxid5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:49 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)) 11:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-gLg5xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:49 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-M4xFLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:49 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)) 11:47:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:47:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:47:49 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)) 11:47:49 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)) 11:47:49 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)) 11:47:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:47:49 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 11:47:49 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 11:47:49 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 11:47:49 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 11:47:49 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 11:47:49 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 11:47:52 INFO - Downloading blessings-1.6.tar.gz 11:47:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:47:52 INFO - Installing collected packages: blessings 11:47:52 INFO - Running setup.py install for blessings 11:47:52 INFO - Successfully installed blessings 11:47:52 INFO - Cleaning up... 11:47:52 INFO - Return code: 0 11:47:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:47:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:52 INFO - Reading from file tmpfile_stdout 11:47:52 INFO - Current package versions: 11:47:52 INFO - blessings == 1.6 11:47:52 INFO - blobuploader == 1.2.4 11:47:52 INFO - docopt == 0.6.1 11:47:52 INFO - functools32 == 3.2.3-2 11:47:52 INFO - jsonschema == 2.5.1 11:47:52 INFO - manifestparser == 1.1 11:47:52 INFO - mozInstall == 1.12 11:47:52 INFO - mozcrash == 1.0 11:47:52 INFO - mozdebug == 0.1 11:47:52 INFO - mozdevice == 0.48 11:47:52 INFO - mozfile == 1.2 11:47:52 INFO - mozhttpd == 0.7 11:47:52 INFO - mozinfo == 0.9 11:47:52 INFO - mozleak == 0.1 11:47:52 INFO - mozlog == 3.4 11:47:52 INFO - moznetwork == 0.27 11:47:52 INFO - mozprocess == 0.23 11:47:52 INFO - mozprofile == 0.28 11:47:52 INFO - mozrunner == 6.13 11:47:52 INFO - mozscreenshot == 0.1 11:47:52 INFO - mozsystemmonitor == 0.3 11:47:52 INFO - moztest == 0.8 11:47:52 INFO - mozversion == 1.4 11:47:52 INFO - psutil == 3.1.1 11:47:52 INFO - requests == 1.2.3 11:47:52 INFO - wsgiref == 0.1.2 11:47:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:52 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 0x106403490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106379570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bad85680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106217d30>, '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 0x10607ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10620fb20>, '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.7es3Mw1mNS/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.x768rAJtia/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 11:47:52 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 11:47:52 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 11:47:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7es3Mw1mNS/Render', 11:47:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:52 INFO - 'HOME': '/Users/cltbld', 11:47:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:52 INFO - 'LOGNAME': 'cltbld', 11:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:52 INFO - 'MOZ_NO_REMOTE': '1', 11:47:52 INFO - 'NO_EM_RESTART': '1', 11:47:52 INFO - 'PAGER': '/bin/cat', 11:47:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:52 INFO - 'PWD': '/builds/slave/test', 11:47:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:52 INFO - 'SHELL': '/bin/bash', 11:47:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x768rAJtia/Listeners', 11:47:52 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 11:47:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:52 INFO - 'USER': 'cltbld', 11:47:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:52 INFO - 'XPC_FLAGS': '0x0', 11:47:52 INFO - 'XPC_SERVICE_NAME': '0', 11:47:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 INFO - Cleaning up... 11:47:53 INFO - Return code: 0 11:47:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106403490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106379570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1bad85680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106217d30>, '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 0x10607ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10620fb20>, '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.7es3Mw1mNS/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.x768rAJtia/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 11:47:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:47:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7es3Mw1mNS/Render', 11:47:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:53 INFO - 'HOME': '/Users/cltbld', 11:47:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:53 INFO - 'LOGNAME': 'cltbld', 11:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:53 INFO - 'MOZ_NO_REMOTE': '1', 11:47:53 INFO - 'NO_EM_RESTART': '1', 11:47:53 INFO - 'PAGER': '/bin/cat', 11:47:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:53 INFO - 'PWD': '/builds/slave/test', 11:47:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:53 INFO - 'SHELL': '/bin/bash', 11:47:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x768rAJtia/Listeners', 11:47:53 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 11:47:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:53 INFO - 'USER': 'cltbld', 11:47:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:53 INFO - 'XPC_FLAGS': '0x0', 11:47:53 INFO - 'XPC_SERVICE_NAME': '0', 11:47:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:47:53 INFO - Cleaning up... 11:47:53 INFO - Return code: 0 11:47:53 INFO - Running post-action listener: _resource_record_post_action 11:47:53 INFO - Running post-action listener: _start_resource_monitoring 11:47:53 INFO - Starting resource monitoring. 11:47:53 INFO - [mozharness: 2017-01-19 19:47:53.362991Z] Finished create-virtualenv step (success) 11:47:53 INFO - [mozharness: 2017-01-19 19:47:53.363983Z] Running install step. 11:47:53 INFO - Running pre-action listener: _resource_record_pre_action 11:47:53 INFO - Running main action method: install 11:47:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:53 INFO - Reading from file tmpfile_stdout 11:47:53 INFO - Detecting whether we're running mozinstall >=1.0... 11:47:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:47:53 INFO - Reading from file tmpfile_stdout 11:47:53 INFO - Output received: 11:47:53 INFO - Usage: mozinstall [options] installer 11:47:53 INFO - Options: 11:47:53 INFO - -h, --help show this help message and exit 11:47:53 INFO - -d DEST, --destination=DEST 11:47:53 INFO - Directory to install application into. [default: 11:47:53 INFO - "/builds/slave/test"] 11:47:53 INFO - --app=APP Application being installed. [default: firefox] 11:47:53 INFO - mkdir: /builds/slave/test/build/application 11:47:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:48:25 INFO - Reading from file tmpfile_stdout 11:48:25 INFO - Output received: 11:48:25 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:48:25 INFO - Running post-action listener: _resource_record_post_action 11:48:25 INFO - [mozharness: 2017-01-19 19:48:25.224069Z] Finished install step (success) 11:48:25 INFO - [mozharness: 2017-01-19 19:48:25.224176Z] Running run-tests step. 11:48:25 INFO - Running pre-action listener: _resource_record_pre_action 11:48:25 INFO - Running main action method: run_tests 11:48:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:48:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:48:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:48:25 INFO - 2017-01-19 11:48:25.238 screenresolution[1971:277562] starting screenresolution argv=screenresolution get 11:48:25 INFO - 2017-01-19 11:48:25.241 screenresolution[1971:277562] Display 0: 1600x1200x32@60 11:48:25 INFO - 2017-01-19 11:48:25.247 screenresolution[1972:277565] starting screenresolution argv=screenresolution list 11:48:25 INFO - Available Modes on Display 0 11:48:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:48:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:48:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:48:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:48:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:48:25 INFO - Intel Iris: 11:48:25 INFO - Chipset Model: Intel Iris 11:48:25 INFO - Type: GPU 11:48:25 INFO - Bus: Built-In 11:48:25 INFO - VRAM (Dynamic, Max): 1536 MB 11:48:25 INFO - Vendor: Intel (0x8086) 11:48:25 INFO - Device ID: 0x0a2e 11:48:25 INFO - Revision ID: 0x0009 11:48:25 INFO - Displays: 11:48:25 INFO - Display: 11:48:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:48:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:48:25 INFO - Display Serial Number: 1600x1200 60 11:48:25 INFO - Main Display: Yes 11:48:25 INFO - Mirror: Off 11:48:25 INFO - Online: Yes 11:48:25 INFO - Rotation: Supported 11:48:25 INFO - Return code: 0 11:48:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:48:25 INFO - Python 2.7.3 11:48:25 INFO - Return code: 0 11:48:25 INFO - grabbing minidump binary from tooltool 11:48:25 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')]} 11:48:25 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 0x106217d30>, '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 0x10607ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10620fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:48:25 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 11:48:25 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 11:48:25 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 11:48:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:48:25 INFO - Return code: 0 11:48:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:48:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:48:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:48:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:48:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:48:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--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 11:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0159 --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 11:48:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7es3Mw1mNS/Render', 11:48:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:25 INFO - 'HOME': '/Users/cltbld', 11:48:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:25 INFO - 'LOGNAME': 'cltbld', 11:48:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:48:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:25 INFO - 'MOZ_NO_REMOTE': '1', 11:48:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:48:25 INFO - 'NO_EM_RESTART': '1', 11:48:25 INFO - 'PAGER': '/bin/cat', 11:48:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:25 INFO - 'PWD': '/builds/slave/test', 11:48:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:48:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:25 INFO - 'SHELL': '/bin/bash', 11:48:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x768rAJtia/Listeners', 11:48:25 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 11:48:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:25 INFO - 'USER': 'cltbld', 11:48:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:25 INFO - 'XPC_FLAGS': '0x0', 11:48:25 INFO - 'XPC_SERVICE_NAME': '0', 11:48:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--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 11:48:25 INFO - mozversion application_buildid: 20170119091728 11:48:25 INFO - mozversion application_changeset: 998f11970867282c85b89385a08bc172ce5b02d2 11:48:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:48:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:48:25 INFO - mozversion application_name: Firefox 11:48:25 INFO - mozversion application_remotingname: firefox-dev 11:48:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:48:25 INFO - mozversion application_vendor: Mozilla 11:48:25 INFO - mozversion application_version: 52.0a2 11:48:25 INFO - mozversion platform_buildid: 20170119091728 11:48:25 INFO - mozversion platform_changeset: 998f11970867282c85b89385a08bc172ce5b02d2 11:48:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:48:25 INFO - mozversion platform_version: 52.0a2 11:48:25 INFO - using testdate: 1484855305 11:48:25 INFO - actual date: 1484855305 11:48:25 INFO - starting webserver on 'localhost:49305' 11:48:25 INFO - SUITE-START | Running 2 tests 11:48:25 INFO - TEST-START | dromaeo_css 11:48:25 INFO - operating with platform_type : mac_ 11:48:25 INFO - Initialising browser for dromaeo_css test... 11:48:25 INFO - TEST-INFO | started process 1982 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmp6Vn7XW/profile http://localhost:49305/getInfo.html) 11:48:28 INFO - PROCESS | 1982 | 2017-01-19 11:48:28.955 plugin-container[1986:277750] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 11:48:28 INFO - PROCESS | 1982 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:48:28 INFO - PROCESS | 1982 | 2017-01-19 11:48:28.958 plugin-container[1986:277750] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4817, name = 'com.apple.CFPasteboardClient' 11:48:28 INFO - PROCESS | 1982 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:48:28 INFO - PROCESS | 1982 | 2017-01-19 11:48:28.958 plugin-container[1986:277750] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:48:29 INFO - PROCESS | 1982 | __metrics Screen width/height:1600/1200 11:48:29 INFO - PROCESS | 1982 | colorDepth:24 11:48:29 INFO - PROCESS | 1982 | Browser inner width/height: 1024/689 11:48:29 INFO - PROCESS | 1982 | __metrics 11:48:29 ERROR - PROCESS | 1982 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 11:48:29 INFO - TEST-INFO | 1982: exit 0 11:48:29 INFO - Browser initialized. 11:48:29 INFO - Running cycle 1/1 for dromaeo_css test... 11:48:29 INFO - TEST-INFO | started process 1987 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmp6Vn7XW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:48:32 INFO - PROCESS | 1987 | 2017-01-19 11:48:32.673 plugin-container[1988:277869] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843b, name = 'com.apple.tsm.portname' 11:48:32 INFO - PROCESS | 1987 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:48:32 INFO - PROCESS | 1987 | 2017-01-19 11:48:32.674 plugin-container[1988:277869] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 11:48:32 INFO - PROCESS | 1987 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:48:32 INFO - PROCESS | 1987 | 2017-01-19 11:48:32.674 plugin-container[1988:277869] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:48:42 INFO - PROCESS | 1987 | RSS: Main: 228900864 11:48:42 INFO - PROCESS | 1987 | 11:51:44 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49305/tests/dromaeo/cssquery-ext.html) 11:51:45 INFO - PROCESS | 1987 | RSS: Main: 236318720 11:51:45 INFO - PROCESS | 1987 | 11:54:48 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-ext.html (next: http://localhost:49305/tests/dromaeo/cssquery-jquery.html) 11:54:48 INFO - PROCESS | 1987 | RSS: Main: 243965952 11:54:48 INFO - PROCESS | 1987 | 11:57:50 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49305/tests/dromaeo/cssquery-mootools.html) 11:57:51 INFO - PROCESS | 1987 | RSS: Main: 247021568 11:57:51 INFO - PROCESS | 1987 | 12:00:53 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49305/tests/dromaeo/cssquery-prototype.html) 12:00:53 INFO - PROCESS | 1987 | RSS: Main: 247291904 12:00:53 INFO - PROCESS | 1987 | 12:03:56 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49305/tests/dromaeo/cssquery-yui.html) 12:03:57 INFO - PROCESS | 1987 | RSS: Main: 250789888 12:03:57 INFO - PROCESS | 1987 | 12:07:00 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-yui.html (next: http://localhost:49305/tests/dromaeo/cssquery-dojo.html) 12:07:00 INFO - PROCESS | 1987 | RSS: Main: 252112896 12:07:00 INFO - PROCESS | 1987 | 12:07:00 INFO - PROCESS | 1987 | __start_tp_report 12:07:00 INFO - PROCESS | 1987 | _x_x_mozilla_page_load 12:07:00 INFO - PROCESS | 1987 | _x_x_mozilla_page_load_details 12:07:00 INFO - PROCESS | 1987 | |i|pagename|runs| 12:07:00 INFO - PROCESS | 1987 | |0;dojo.html;2726.236653736954;2860.6567211934566;3263.3636440894034;3272.869085236589;3275.5905511811025;5410.215518749779;5456.727163641812;5468.152436372364;5483.232347471348;5551.611387202897;4608.53914608539;5426.023315803154;5553.750081246343;5594.992901277768;5610.214569960209;5043.747812609364;5092.745362731848;5139.768710408022;5152.768125434364;5159.277701121827;4480.283154695249;4909.803607855682;5103.8468845934685;5171.250168725533;5205;4870.65905386623;4899.069176856386;5138.460461651529;5142.177251639739;5163.32876726027;4955.975220123913;4964.180910149821;5041.823536176216;5103.795848166069;5127.76942030218;5044.747762611854;5053.140966035783;5058.620603454756;5058.848234552969;5077.593792496591;5523.751431185607;5561.443855614447;5643.125315576092;5649.661020338752;5651.378348381675;5875.588708790387;5944.702764861783;6031.668258245794;6045.848853778647;6074.757009719606;6102.96948515259;6118.204633397674;6132.356102609207;6154.230721159855;6156.7537298508005;5331.760070796746;5639.15412688096;5642.576806739511;5653.547716182778;5656.943430565641;5965.105234214816;6036.245469316335;6045.153678485016;6054.364291749391;6123.081537769282;5865.20819689345;5920.289565252111;5928.170056192136;5954.136650185699;5966.492848107872;6068.8786224276155;6069.9089513656445;6077.027675571887;6079.05774604937;6087.9391206087375;5606.074997625427;5682.715864206773;5937.228160339215;5942.37605051472;6031.336552979169;5733.913991290134;5756.539476841843;5819.127130930395;5867.941320586825;5895.35151133375;4806.49531799163;4810.59109975649;4823.975880120577;4831.99999999993;4849.587785038311;4263.040815816478;4284.55012223712;4303.2469317869245;4304.892377690583;4333.133373325348;5233.319668443078;5280.815171469057;5387.4073851876265;5522.22688823557;5572.749226284745;5369.7583608737705;5931.614445061144;6012.729427175787;6086.1175129606845;6110.984061328523;5260.605454590921;5344.144936810092;5488.56091512678;5603.579731520153;5612.242347283146;5226.111561034633;5239.214117882349;5247.895042099213;5265.157574788015;5356.678599284055;4344.587264209895;5385.219143224211;5845.41545845412;6297.685115744194;6323.525735569759;6014.127951447103;6048.727807248596;6097.725602347817;6148.077788331786;6148.815535533941;4701.811927522861;5222.2688823565495;6258.030005349178;6277.1525844010475;6292.622442653455;4574.382458368078;6016.42843929826;6016.759329626766;6024.819255422344;6029.4874935629205;5727.455891690282;5991.64050156992;6039.577229593886;6063.878722425615;6110.224634763573;4888.364512613338;5731.254936858182;5893.204417403767;5897.705114744332;5901.114832775118;5784.537237021113;5817.738201780845;5824.796132135524;5839.386864379179;5845.503132233808;5412.75642596092;5455.290812194389;5466.180072989084;5612.5509959202345;5613.747381367766;5765;5772.7690892363835;5811.82564523065;5817.214676018683;5823.912641310299;5647.040003199548;5656.519195868233;5664.631798933056;5673.234113394804;5675.545956323567 12:07:00 INFO - PROCESS | 1987 | |1;ext.html;472.1642692434391;477.16496131769395;480.50747983317075;517.9666565202422;531.6942757914198;33854.66145338549;39225.019374515614;41284.17431651365;41316.17367652645;41443.79278103613;41545.792271038605;42163;42251.36622950658;42297.36553951685;42350.15299694004;7938;9368.625254989793;9481.71554853352;9496;9507.619695212183;9266.490343031131;9342.532873356338;9379.671711490098;9385.906140938605;9423.434593924387;9359.391639543443;9377.859332110023;9410.858837117414;9431.575579098957;9435.528223588828;9324.300677449184;9376;9376.296777741696;9390.62437502499;9396.953015234949;9346.719598412059;9385.202257808094;9394.95302523483;9428.952855235748;9439.905600943972;40469.19061618781;40709.77870663885;40815.387769183486;40853.59146408557;40946.79526602348;3453.8791142309897;3514.139035936212;3775.6601905828334;3915.1599097191292;3977.7414468059483;24959.62560561593;29615;29960.8501957491;31617.367652647048;31898.362032759214;3073.938521229585;3152.9684703153134;3208.614966204047;3238.3685181389637;3327.2014716468116;440700.59299407236;465725.0141247884;490139.99999999645;491982;492532;59248.407515924286;59870.401295986485;59942.700286498286;60017.99999999913;60399.69800151059;54189.1871621926;60328.39671603315;65214.34785652083;65390;65489.67255163693;16198.514044578682;16238.75641865373;16421.835781642032;16457.670846583;16467.258973346226;12312.076594255466;12552.623421297192;12585.496580136874;12683.365831708377;12694.857462828206;18189;18350.082495875155;18401.3559525416;18407.171677274553;18550;5984.461398474158;6755.49333799967;6865.794026179223;6959.3463431698765;7005.614691191931;865.3164000439708;947.7772723409993;1014.7006633043122;1024.6516184497157;1105.4638500327335;23414.414639634146;29062.70937290642;29585;30061.398772024437;30648.387032259678;854.8546747053016;1052.8578641883248;1056.894310568937;1116.3023110555903;1146.1919346860443;13278.402471888789;15951.840481595267;16728;16866.560762509976;17250.827491725173;552729;670975;673697.6315118491;675542;677195;58234;58798.11802822961;58889;59322.70338648279;59361.406385936454;1324.1326930860303;1347.2320777157122;1362.7206422683325;1362.8228330316995;1366.0983750724672;30429.239269018453;30910.0726978191;31704.524432133996;31885.36229275448;32251;52274;55385.892282154935;57035;57084.714576428516;60284.69857650684;586414;590846;592272.038639804;592285;593986;26380;26708.599371009837;26729;26759.464810704067;26805.597916030885;46532.7673361631;46850.76574617105;47427;47725.04549909052;48235.517644824504;38652.45390184361;38756.6124338753;39680.2063958725;39898.411682656864;40964.1807163861;26880.32799180036;34040.65959340474;38997.2200555993;39772.60227397689;40008.39966401428;37682.62317376791;38278.808605956794;38572.421413678254;38624.03439914025;39051;31991.360172796878;33133;34466;35087.29825403529;35284.47073293954;25723.170451249975;25811.612825807253;25858;25899.223023309332;26259 12:07:00 INFO - PROCESS | 1987 | |2;jquery.html;318.37121684672786;332.35025525098433;378.235963354025;386.0483907168828;400.80959550136083;17322.653546929054;18457.53856153597;19989.100490477944;20031.298904538344;20253.291134810286;19542.90228548855;19659.5085122872;19946.40160795175;20243.190272389085;20458;5365.570754339644;5581.302337207849;5583.944160558383;5597.020521408757;5606.046972014768;5350.732463376835;5642.15367694847;5658.688772117532;5711.971440142815;5712.857178570527;4754.524547545252;4756.952430475685;5108.259302401149;5439.374471935718;5668.659880407189;4381.3647021181905;4843.24929635907;5543.113101903697;5592.944070559323;5597.104463285896;4613.6620380089735;4679.812807487697;4932.8520144395725;4958.578520825698;4969;20884.686729699068;22461.21385751507;25142.49715005708;25283.367915802253;25296.747032529805;2188.5075857931997;2269.1490690990877;2449.497852940143;2466.9136580219606;3017.215523963785;14548.636284092876;14912.925435372754;14926.40294388223;14964.551063468114;15904.920475397665;1811.9547011324692;1842.97235541467;1928.701051337045;1931.0923865783059;1954.7067939809;115525.4223728876;116824;119589.80410195874;119788.40105799503;120618.3969080149;11299.039581635489;11394.031507321804;11599.304041757352;11651.126165537618;11822.704432389259;14505.927470362582;14667.266636668124;14676.55970320892;14677.119372837664;14704.926475367769;8204.343652507785;8476.194761497647;8499.74500764978;8560.61477233526;8605.569721513899;8350.373721970876;8368.3305335573;8392.748217553482;8440.071592124861;8498.23515883561;4452.844150454718;4478.216312145361;4527.4340707411575;4554.248548989446;4579.793909274024;1877.9248830046918;1910.6274276515946;1935.5935253596622;1977.525393905481;1984.4443555804398;361.69617521281725;370.76085924578496;405.41012826337607;811.2131232704268;927.4296307770808;11683.532658693726;11736.94131529354;11772.587959421551;11790.587329443428;11938.701532461759;436.7314101827353;807.4872455990488;888.6623083228332;912.7854954085784;972.8297547929226;9930.950345248228;10904.182186336056;10933.343999359904;10944.781104378028;10947;607902;614215;621437;623560;624856;113553;131682.68317316895;132540.3372983129;135586;139440.30279848535;950.6767698982379;968.7142293023575;992.2161492420906;994.229472159068;1007.6473234367912;12656.936715316364;18423.907880460512;19532.511687207367;19582.412527623623;19848.603027939072;55894.44105559055;56135.71932140313;57140;57734.13398798937;59278.70360648169;84349.57825210835;86124.13875861162;86219.27561448861;87525;88349.55825220833;6843.486738494533;7961.641726122222;7969.282764551218;8020.679172833022;8254.711085111992;10958.726031849268;12030.819537706766;12645;12848.935755321538;13030.47878084866;9911.45486998222;10833.512491937725;11132.833007505056;11450.599229027277;11501.53993840237;8291.95854020726;9958.651447199314;10453.843192352273;11154.996050355507;11209.719757005814;9485.620575176916;11378.260413073123;11609;11610.6516804496;11741.823872642088;6773.288804675438;7967.123616402307;7977.641006154621;8058.99262592176;8325.25072743456;9979.950100249453;10131.341462804894;10182.847257291294;10452.738681532719;11158.386288754196 12:07:00 INFO - PROCESS | 1987 | |3;mootools.html;1455.0760267230312;1492.8283247426546;1667.374734474572;1771.9114044297783;1824.8083951185117;7521.811954701136;7815.257550532705;8130.105688374281;8538.786530336736;8583.914160858389;7123.252058533857;8053.355731541477;8293.709720159795;8467;8477.576121193946;2023.6340470182568;2037.5822956293923;2296.2537175418015;2298.6207275799475;2354.1289722802585;2230.431240033789;2334.6147885598857;2393.9162129325478;2396.4727759892794;2399.076355603088;2310.341552657493;2324.6280595104786;2348.1077190667525;2363.432776133724;2366.2546297916188;2325.360525855386;2330.067972810872;2346.6245400735884;2348.213348528245;2350.2009316832273;2352.3178278299274;2367.30164601443;2373.3947843299848;2376.370261880603;2384.332386931662;8432.789180270482;8463.619137138843;8506.787330316729;8517.318614510887;8529.658813647447;4294.720843145217;5244.8688782780355;5255.789768409259;5264.9733302006125;5268.157094864841;3342.565466489341;3456.274182421669;3594.029612004744;3616.7649102808496;3661.4690869823726;871.4030888841164;1032.958681652733;1071.9732006699817;1104.6741211342594;1111.0722546673537;9182.26541876655;10961.506732196991;11024.50389732464;11027.944860275808;11062.39156846373;4526.7283962961665;4633.166030114544;4700.905981880412;4733.881652958635;4775.928361074587;7948.642311096015;8287.715404112372;9126.13301736334;9500.904990950141;9592.472414017297;5254.816081437208;5265.815696450606;5270.92093618596;5278.261043453919;5294.126469132627;4097.672186225095;4785.976070119627;4850.078485087893;4850.53919877611;4870.537298956593;3830.731848770615;3832.405977073558;3912.68698504119;3930.371140617545;3948.9605103949166;1273.4651446392538;1291.5285920639087;1293.9805902911464;1301.342821874966;1304.2891624064907;807.4832107451236;881.5680316644798;901.677516522501;912.6896855069308;927.8793756811572;5566.165075238747;5777.855553611109;5866.765329386777;5904.468597826216;5915.822525324161;897.9146981036922;917.3486824354783;923.1230331185401;930.6184464369576;966.6665000574791;3756.9060773480337;3836.635519625687;3861.5945325740954;3906.374980003186;3939.7392834293323;9944.80110397788;10474.423906685206;10487.632932847466;10506.579736810441;10515.52680129396;10407.959204079683;10429.739256518496;10451.790964180675;10477.161827053817;10480.213983951235;6635.966820165868;7655.885161722578;8009.7997550060545;8018.639161237758;8032.1164671886045;5534.4742249486235;5598.1322894951345;5700.572457065819;5730.799422020376;5756.798512052058;7826;8511.787205319917;9546.522673866419;9703.272254580794;9732.46471444049;9420.62317507292;9482.525873706149;9649.807003860024;9700.514974251118;9743.074407931235;7196.388306993964;7398.038255026812;7704.8459030820195;7853.175416581176;8024.719134830487;7939.364850811806;8163.142869998802;8192.344612430872;8203.71287004952;8215.835683286421;7127.180374257026;7191.316824901626;7213.567185968858;7370.115586129698;7377.372923301579;6999.440044796303;7068.752593659197;7101.893471597827;7201.207867134715;7217.494775365884;6811.829704257235;6825.453963682993;6878.518503704692;6886.035954966209;6896.586204827727;4866.419322635066;4918.0901533216465;4957.603391728725;5004.974975125101;5005;4687.718736875799;4869.537393947569;4906.411230652202;4928.704277743347;5022.121128802518 12:07:00 INFO - PROCESS | 1987 | |4;prototype.html;289.3460778640274;291.7869954932899;304.0847050378361;307.3928990244269;307.99900323947173;4387.3418987151945;4409.470863496377;4783.976080119599;5139.922901156481;5192.844214673556;4268.57314268573;4268.679849011329;5000.374878164602;5153.76808043638;5207.3490813648295;3819.885403437894;3893.299206142893;3936.9960660031793;3987.9800600996955;4026.2953983052994;3704.092497338156;4003.519577650686;4039.141994682435;4039.596040395966;4041.2321658884716;3691.4093745000805;3911.8630847920326;3930.430087637291;3937.9015524611827;3944.408338749182;3157.6842315768467;3463.839613729416;3949.7037722170808;3950.407438884162;3959.425883246913;2969.940601187964;3446.362422951762;3461.6365281645317;3467.271872906693;3480.112571294329;4001.7198796084285;4838.274258861164;4881.292212629149;4972.353594032753;4997.400311962588;4498.415206023229;4521.751303678297;4522.241432726035;4524.389207456984;4526.547345265447;4562.954370456286;5445.9727701361635;5491.093969495028;5491.917621235645;5501.626207165274;3283.96716032839;3624.151682641845;3757.1922036761953;3787.3750831112834;3791.1233939199997;4751.97832466018;4806.78369473371;5137.537621614073;5724.484796368305;5728.283964504437;3770.9057273567832;3797.7911214883447;3800.7149463790324;3803.904902377463;3820.6179382061573;3703.8147792706613;3851.1527463957887;3872.7869967151514;3892.163184915257;3894.8120823148647;3909.4722212501515;4083.5916408358926;4303.397524346594;4413.889652758707;4464.687471877002;4799.688020278671;5488.341399032141;5495.890082198413;5531.115021596525;5548.639338443069;1079.3216548267362;1151.746615744535;1174.5142394870495;1187.7446349035;1248.7627350803318;829.2122483640566;843.4264700004056;857.2584714222153;859.7034023261965;862.6118246788844;4452.777361131931;4784.952150478521;4902.034269267042;4951.554360107608;4956.5786908112495;4880.292357608198;5152.819651312186;5365.892682146336;5376;5408.621396502207;4223.894402639897;4633;4669.883252918704;4813.302071199656;4931.260310953386;2553.812477198112;2753.9586906196423;2765.308672831792;2783.5685468752376;2800.957985630217;4802.855914322576;5411.4036359274105;5428.70142142186;5459.808906688327;5461.9453805462235;4402.757848318373;4502.032063106382;4898.81576974962;5125.666831655931;5375.9462405376225;4695.886850917101;5316.6872410501555;5326.520613144836;5435.602748282324;5472.878059997771;4340.85288166077;4864.713584615225;5288.312519372611;5331;5356.303680521663;4171.416001759695;4574.565416285448;4630.663688576877;5210.374755029421;5272.44639312882;4431.955680443283;4524.253498172896;5299.947000529945;5463.808766693147;5467.480589344006;3248.3503299339754;3346.1300061983575;3537.9292414152087;3569.464580312974;3616.571454275494;4050.67594592426;4859.586935110555;4977.502249774993;5227.032998895216;5307.4692530746615;4670.392848929753;5536.141898005815;5605.729679479818;5620.269364982526;5624.5376202188545;5586.832395028156;5600.27196464457;5613.522850557748;5617.494425501724;5639.661620302795;4460.687751857339;4514.819407223675;5249.900039983884;5413.347459744776;5436.565074793928;4368.781560921878;5481.260029895913;5554.944450555443;5562.2490963721;5594.580406469449;5445.40100588927;5462.8361149165585;5472.863178420572;5507.972460137674;5524.4199359068325 12:07:00 INFO - PROCESS | 1987 | |5;yui.html;583.8585565219995;614.6342925959053;681.6864242448473;689.369227157151;726.9818254543636;14092.577222683323;14856.554303370916;14867.851321486782;14876.925615371922;14886;13104.213747175152;13227.338633068332;13252.403641836116;13270.469181232738;13290.534831280907;634.0679201573679;657.6317262333085;788.2078511096369;807.5598798654732;823.0288259853371;718.3032458515232;799.7041094794905;816.677412422093;820.729159377404;823.8013690080918;872.7992561710811;874.6938571499987;874.846901792187;874.8512752832033;877.2937785083005;835.3985130705883;862.0043849354006;870.0646804684957;871.8735783311448;871.9869201961976;635.2567496029657;636.9681515924185;644.8678021005683;645.2805122288614;645.4352441613588;14115.060827858491;14454.638634034232;14455.494057708034;14569.562913112624;14592.562223133324;11361.829572556418;13408.86591134086;13595.728085438235;13835.100718453268;13973.650658733512;9307.208887244524;10444.634437794717;11083.445827708663;11205.461787975883;11214.66356009321;4330.610245077958;4337.306031035019;4370.737755734666;4382.123575284924;4445.088756804847;83652.58173709092;83924.74112888312;84664;85567.71648425279;87305;8631.180037896389;10063.496825158712;10127.189824813997;10197.898021019842;10226.335288206243;18879.62240755177;18905.432837014912;19053.04734763284;19058.90470547666;19213.711794323095;7101.786946391617;7195.676194571257;7240.275972402717;7346.265373462611;7365.963170184222;4078.347464405681;4172.4784401949755;4177.8328866845595;4181.749095054306;4183.832646694098;3178.173674844511;3242.2866969266724;3275.082976766509;3283.1627934876456;3287.901362959115;615.2678312807744;626.5927147354256;628.3904612525843;629.3643420145594;639.0254861336406;478.3255609590461;484.63894398673216;494.97030178189425;541.6939429222476;581.430198405565;7170.6056166910275;7898.526088434713;8228;8511.467935771496;8703.564821758886;534.5376249544116;578.5574035862569;588.5732843688377;591.5949619653323;620.8230654263604;4057.5739547347694;4230.450041494586;4257.829686812493;4267.935980960288;4290.059387802878;75918;76344.85482717764;79049;117058.41470792591;127315;41937.16125677469;66977.6651116751;78404.60797695976;81098.59450702826;87209.56395217983;72151.6392418045;81748.59125704452;91795;94120.58819117719;94177.529112354;8717.953845538575;9268.768280793034;9280;9281.211097056826;9300.674476393564;42047.57952420559;43193.3520997179;52953.47046529486;56011.719941400035;57685.42314576801;27894.60526973684;29590.556141658322;68437.65781171063;77197;80237.19762802531;11988.700282492659;12026.27842329463;12226.633201003984;12392.442340094898;12673.30296833683;13367.665808354868;13483.528076517276;13840.169589824643;13919.373628186553;14163.433462661378;12251.264924104582;12797.552085676956;13178.868211317764;13633.250171240677;13679.521216757366;12273.35147686671;12985.610431687064;13134.408951597392;13492.865071349554;13555.525556605471;11758.221021581789;13170.143940643828;13192.538261160813;13554.25451600132;13607.591772246848;10274.897251027693;10468.738281543023;11363.886361136283;11451.885481145082;11486.540538378706;10572.36565806054;11185.944070279596;11192.552297908318;11408.486618102039;11448.255863368855 12:07:00 INFO - PROCESS | 1987 | __end_tp_report 12:07:00 INFO - PROCESS | 1987 | __start_cc_report 12:07:00 INFO - PROCESS | 1987 | _x_x_mozilla_cycle_collect,374 12:07:00 INFO - PROCESS | 1987 | __end_cc_report 12:07:00 INFO - PROCESS | 1987 | __startTimestamp1484856420351__endTimestamp 12:07:00 INFO - PROCESS | 1987 | 12:07:00 INFO - PROCESS | 1987 | ------- Summary: start ------- 12:07:00 INFO - PROCESS | 1987 | Number of tests: 6 12:07:00 INFO - PROCESS | 1987 | 12:07:00 INFO - PROCESS | 1987 | [#0] dojo.html Cycles:165 Average:5484.13 Median:5642.58 stddev:645.50 (11.4%) stddev-sans-first:610.15 12:07:00 INFO - PROCESS | 1987 | Values: 2726.2 2860.7 3263.4 3272.9 3275.6 5410.2 5456.7 5468.2 5483.2 5551.6 4608.5 5426.0 5553.8 5595.0 5610.2 5043.7 5092.7 5139.8 5152.8 5159.3 4480.3 4909.8 5103.8 5171.3 5205.0 4870.7 4899.1 5138.5 5142.2 5163.3 4956.0 4964.2 5041.8 5103.8 5127.8 5044.7 5053.1 5058.6 5058.8 5077.6 5523.8 5561.4 5643.1 5649.7 5651.4 5875.6 5944.7 6031.7 6045.8 6074.8 6103.0 6118.2 6132.4 6154.2 6156.8 5331.8 5639.2 5642.6 5653.5 5656.9 5965.1 6036.2 6045.2 6054.4 6123.1 5865.2 5920.3 5928.2 5954.1 5966.5 6068.9 6069.9 6077.0 6079.1 6087.9 5606.1 5682.7 5937.2 5942.4 6031.3 5733.9 5756.5 5819.1 5867.9 5895.4 4806.5 4810.6 4824.0 4832.0 4849.6 4263.0 4284.6 4303.2 4304.9 4333.1 5233.3 5280.8 5387.4 5522.2 5572.7 5369.8 5931.6 6012.7 6086.1 6111.0 5260.6 5344.1 5488.6 5603.6 5612.2 5226.1 5239.2 5247.9 5265.2 5356.7 4344.6 5385.2 5845.4 6297.7 6323.5 6014.1 6048.7 6097.7 6148.1 6148.8 4701.8 5222.3 6258.0 6277.2 6292.6 4574.4 6016.4 6016.8 6024.8 6029.5 5727.5 5991.6 6039.6 6063.9 6110.2 4888.4 5731.3 5893.2 5897.7 5901.1 5784.5 5817.7 5824.8 5839.4 5845.5 5412.8 5455.3 5466.2 5612.6 5613.7 5765.0 5772.8 5811.8 5817.2 5823.9 5647.0 5656.5 5664.6 5673.2 5675.5 12:07:00 INFO - PROCESS | 1987 | 12:07:00 INFO - PROCESS | 1987 | [#1] ext.html Cycles:180 Average:70614.03 Median:40834.49 stddev:154501.48 (378.4%) stddev-sans-first:154845.15 12:07:00 INFO - PROCESS | 1987 | Values: 472.2 477.2 480.5 518.0 531.7 33854.7 39225.0 41284.2 41316.2 41443.8 41545.8 42163.0 42251.4 42297.4 42350.2 7938.0 9368.6 9481.7 9496.0 9507.6 9266.5 9342.5 9379.7 9385.9 9423.4 9359.4 9377.9 9410.9 9431.6 9435.5 9324.3 9376.0 9376.3 9390.6 9397.0 9346.7 9385.2 9395.0 9429.0 9439.9 40469.2 40709.8 40815.4 40853.6 40946.8 3453.9 3514.1 3775.7 3915.2 3977.7 24959.6 29615.0 29960.9 31617.4 31898.4 3073.9 3153.0 3208.6 3238.4 3327.2 440700.6 465725.0 490140.0 491982.0 492532.0 59248.4 59870.4 59942.7 60018.0 60399.7 54189.2 60328.4 65214.3 65390.0 65489.7 16198.5 16238.8 16421.8 16457.7 16467.3 12312.1 12552.6 12585.5 12683.4 12694.9 18189.0 18350.1 18401.4 18407.2 18550.0 5984.5 6755.5 6865.8 6959.3 7005.6 865.3 947.8 1014.7 1024.7 1105.5 23414.4 29062.7 29585.0 30061.4 30648.4 854.9 1052.9 1056.9 1116.3 1146.2 13278.4 15951.8 16728.0 16866.6 17250.8 552729.0 670975.0 673697.6 675542.0 677195.0 58234.0 58798.1 58889.0 59322.7 59361.4 1324.1 1347.2 1362.7 1362.8 1366.1 30429.2 30910.1 31704.5 31885.4 32251.0 52274.0 55385.9 57035.0 57084.7 60284.7 586414.0 590846.0 592272.0 592285.0 593986.0 26380.0 26708.6 26729.0 26759.5 26805.6 46532.8 46850.8 47427.0 47725.0 48235.5 38652.5 38756.6 39680.2 39898.4 40964.2 26880.3 34040.7 38997.2 39772.6 40008.4 37682.6 38278.8 38572.4 38624.0 39051.0 31991.4 33133.0 34466.0 35087.3 35284.5 25723.2 25811.6 25858.0 25899.2 26259.0 12:07:00 INFO - PROCESS | 1987 | 12:07:00 INFO - PROCESS | 1987 | [#2] jquery.html Cycles:180 Average:35649.05 Median:325.36 stddev:103322.24 (31756.2%) stddev-sans-first:103578.03 12:07:00 INFO - PROCESS | 1987 | Values: 318.4 332.4 378.2 386.0 400.8 17322.7 18457.5 19989.1 20031.3 20253.3 19542.9 19659.5 19946.4 20243.2 20458.0 5365.6 5581.3 5583.9 5597.0 5606.0 5350.7 5642.2 5658.7 5712.0 5712.9 4754.5 4757.0 5108.3 5439.4 5668.7 4381.4 4843.2 5543.1 5592.9 5597.1 4613.7 4679.8 4932.9 4958.6 4969.0 20884.7 22461.2 25142.5 25283.4 25296.7 2188.5 2269.1 2449.5 2466.9 3017.2 14548.6 14912.9 14926.4 14964.6 15904.9 1812.0 1843.0 1928.7 1931.1 1954.7 115525.4 116824.0 119589.8 119788.4 120618.4 11299.0 11394.0 11599.3 11651.1 11822.7 14505.9 14667.3 14676.6 14677.1 14704.9 8204.3 8476.2 8499.7 8560.6 8605.6 8350.4 8368.3 8392.7 8440.1 8498.2 4452.8 4478.2 4527.4 4554.2 4579.8 1877.9 1910.6 1935.6 1977.5 1984.4 361.7 370.8 405.4 811.2 927.4 11683.5 11736.9 11772.6 11790.6 11938.7 436.7 807.5 888.7 912.8 972.8 9931.0 10904.2 10933.3 10944.8 10947.0 607902.0 614215.0 621437.0 623560.0 624856.0 113553.0 131682.7 132540.3 135586.0 139440.3 950.7 968.7 992.2 994.2 1007.6 12656.9 18423.9 19532.5 19582.4 19848.6 55894.4 56135.7 57140.0 57734.1 59278.7 84349.6 86124.1 86219.3 87525.0 88349.6 6843.5 7961.6 7969.3 8020.7 8254.7 10958.7 12030.8 12645.0 12848.9 13030.5 9911.5 10833.5 11132.8 11450.6 11501.5 8292.0 9958.7 10453.8 11155.0 11209.7 9485.6 11378.3 11609.0 11610.7 11741.8 6773.3 7967.1 7977.6 8059.0 8325.3 9980.0 10131.3 10182.8 10452.7 11158.4 12:07:00 INFO - PROCESS | 1987 | 12:07:00 INFO - PROCESS | 1987 | [#3] mootools.html Cycles:180 Average:5502.80 Median:5260.38 stddev:2997.89 (57.0%) stddev-sans-first:2990.87 12:07:00 INFO - PROCESS | 1987 | Values: 1455.1 1492.8 1667.4 1771.9 1824.8 7521.8 7815.3 8130.1 8538.8 8583.9 7123.3 8053.4 8293.7 8467.0 8477.6 2023.6 2037.6 2296.3 2298.6 2354.1 2230.4 2334.6 2393.9 2396.5 2399.1 2310.3 2324.6 2348.1 2363.4 2366.3 2325.4 2330.1 2346.6 2348.2 2350.2 2352.3 2367.3 2373.4 2376.4 2384.3 8432.8 8463.6 8506.8 8517.3 8529.7 4294.7 5244.9 5255.8 5265.0 5268.2 3342.6 3456.3 3594.0 3616.8 3661.5 871.4 1033.0 1072.0 1104.7 1111.1 9182.3 10961.5 11024.5 11027.9 11062.4 4526.7 4633.2 4700.9 4733.9 4775.9 7948.6 8287.7 9126.1 9500.9 9592.5 5254.8 5265.8 5270.9 5278.3 5294.1 4097.7 4786.0 4850.1 4850.5 4870.5 3830.7 3832.4 3912.7 3930.4 3949.0 1273.5 1291.5 1294.0 1301.3 1304.3 807.5 881.6 901.7 912.7 927.9 5566.2 5777.9 5866.8 5904.5 5915.8 897.9 917.3 923.1 930.6 966.7 3756.9 3836.6 3861.6 3906.4 3939.7 9944.8 10474.4 10487.6 10506.6 10515.5 10408.0 10429.7 10451.8 10477.2 10480.2 6636.0 7655.9 8009.8 8018.6 8032.1 5534.5 5598.1 5700.6 5730.8 5756.8 7826.0 8511.8 9546.5 9703.3 9732.5 9420.6 9482.5 9649.8 9700.5 9743.1 7196.4 7398.0 7704.8 7853.2 8024.7 7939.4 8163.1 8192.3 8203.7 8215.8 7127.2 7191.3 7213.6 7370.1 7377.4 6999.4 7068.8 7101.9 7201.2 7217.5 6811.8 6825.5 6878.5 6886.0 6896.6 4866.4 4918.1 4957.6 5005.0 5005.0 4687.7 4869.5 4906.4 4928.7 5022.1 12:07:00 INFO - PROCESS | 1987 | 12:07:00 INFO - PROCESS | 1987 | [#4] prototype.html Cycles:180 Average:4285.85 Median:4651.44 stddev:1305.40 (28.1%) stddev-sans-first:1274.13 12:07:00 INFO - PROCESS | 1987 | Values: 289.3 291.8 304.1 307.4 308.0 4387.3 4409.5 4784.0 5139.9 5192.8 4268.6 4268.7 5000.4 5153.8 5207.3 3819.9 3893.3 3937.0 3988.0 4026.3 3704.1 4003.5 4039.1 4039.6 4041.2 3691.4 3911.9 3930.4 3937.9 3944.4 3157.7 3463.8 3949.7 3950.4 3959.4 2969.9 3446.4 3461.6 3467.3 3480.1 4001.7 4838.3 4881.3 4972.4 4997.4 4498.4 4521.8 4522.2 4524.4 4526.5 4563.0 5446.0 5491.1 5491.9 5501.6 3284.0 3624.2 3757.2 3787.4 3791.1 4752.0 4806.8 5137.5 5724.5 5728.3 3770.9 3797.8 3800.7 3803.9 3820.6 3703.8 3851.2 3872.8 3892.2 3894.8 3909.5 4083.6 4303.4 4413.9 4464.7 4799.7 5488.3 5495.9 5531.1 5548.6 1079.3 1151.7 1174.5 1187.7 1248.8 829.2 843.4 857.3 859.7 862.6 4452.8 4785.0 4902.0 4951.6 4956.6 4880.3 5152.8 5365.9 5376.0 5408.6 4223.9 4633.0 4669.9 4813.3 4931.3 2553.8 2754.0 2765.3 2783.6 2801.0 4802.9 5411.4 5428.7 5459.8 5461.9 4402.8 4502.0 4898.8 5125.7 5375.9 4695.9 5316.7 5326.5 5435.6 5472.9 4340.9 4864.7 5288.3 5331.0 5356.3 4171.4 4574.6 4630.7 5210.4 5272.4 4432.0 4524.3 5299.9 5463.8 5467.5 3248.4 3346.1 3537.9 3569.5 3616.6 4050.7 4859.6 4977.5 5227.0 5307.5 4670.4 5536.1 5605.7 5620.3 5624.5 5586.8 5600.3 5613.5 5617.5 5639.7 4460.7 4514.8 5249.9 5413.3 5436.6 4368.8 5481.3 5554.9 5562.2 5594.6 5445.4 5462.8 5472.9 5508.0 5524.4 12:07:00 INFO - PROCESS | 1987 | 12:07:00 INFO - PROCESS | 1987 | [#5] yui.html Cycles:180 Average:18737.35 Median:4333.96 stddev:27008.61 (623.2%) stddev-sans-first:27049.98 12:07:00 INFO - PROCESS | 1987 | Values: 583.9 614.6 681.7 689.4 727.0 14092.6 14856.6 14867.9 14876.9 14886.0 13104.2 13227.3 13252.4 13270.5 13290.5 634.1 657.6 788.2 807.6 823.0 718.3 799.7 816.7 820.7 823.8 872.8 874.7 874.8 874.9 877.3 835.4 862.0 870.1 871.9 872.0 635.3 637.0 644.9 645.3 645.4 14115.1 14454.6 14455.5 14569.6 14592.6 11361.8 13408.9 13595.7 13835.1 13973.7 9307.2 10444.6 11083.4 11205.5 11214.7 4330.6 4337.3 4370.7 4382.1 4445.1 83652.6 83924.7 84664.0 85567.7 87305.0 8631.2 10063.5 10127.2 10197.9 10226.3 18879.6 18905.4 19053.0 19058.9 19213.7 7101.8 7195.7 7240.3 7346.3 7366.0 4078.3 4172.5 4177.8 4181.7 4183.8 3178.2 3242.3 3275.1 3283.2 3287.9 615.3 626.6 628.4 629.4 639.0 478.3 484.6 495.0 541.7 581.4 7170.6 7898.5 8228.0 8511.5 8703.6 534.5 578.6 588.6 591.6 620.8 4057.6 4230.5 4257.8 4267.9 4290.1 75918.0 76344.9 79049.0 117058.4 127315.0 41937.2 66977.7 78404.6 81098.6 87209.6 72151.6 81748.6 91795.0 94120.6 94177.5 8718.0 9268.8 9280.0 9281.2 9300.7 42047.6 43193.4 52953.5 56011.7 57685.4 27894.6 29590.6 68437.7 77197.0 80237.2 11988.7 12026.3 12226.6 12392.4 12673.3 13367.7 13483.5 13840.2 13919.4 14163.4 12251.3 12797.6 13178.9 13633.3 13679.5 12273.4 12985.6 13134.4 13492.9 13555.5 11758.2 13170.1 13192.5 13554.3 13607.6 10274.9 10468.7 11363.9 11451.9 11486.5 10572.4 11185.9 11192.6 11408.5 11448.3 12:07:00 INFO - PROCESS | 1987 | -------- Summary: end -------- 12:07:00 INFO - PROCESS | 1987 | 12:07:01 INFO - TEST-INFO | 1987: exit 0 12:07:01 INFO - TEST-OK | dromaeo_css | took 1115230ms 12:07:01 INFO - TEST-START | kraken 12:07:01 INFO - operating with platform_type : mac_ 12:07:01 INFO - Initialising browser for kraken test... 12:07:01 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpn86v8y/profile http://localhost:49305/getInfo.html) 12:07:04 INFO - PROCESS | 1994 | 2017-01-19 12:07:04.125 plugin-container[1995:280042] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x853f, name = 'com.apple.tsm.portname' 12:07:04 INFO - PROCESS | 1994 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:07:04 INFO - PROCESS | 1994 | 2017-01-19 12:07:04.130 plugin-container[1995:280042] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 12:07:04 INFO - PROCESS | 1994 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:07:04 INFO - PROCESS | 1994 | 2017-01-19 12:07:04.130 plugin-container[1995:280042] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:07:04 INFO - PROCESS | 1994 | __metrics Screen width/height:1600/1200 12:07:04 INFO - PROCESS | 1994 | colorDepth:24 12:07:04 INFO - PROCESS | 1994 | Browser inner width/height: 1024/689 12:07:04 INFO - PROCESS | 1994 | __metrics 12:07:04 ERROR - PROCESS | 1994 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 12:07:05 INFO - TEST-INFO | 1994: exit 0 12:07:05 INFO - Browser initialized. 12:07:05 INFO - Running cycle 1/1 for kraken test... 12:07:05 INFO - TEST-INFO | started process 1996 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpn86v8y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:07:07 INFO - PROCESS | 1996 | 2017-01-19 12:07:07.903 plugin-container[1997:280164] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 12:07:07 INFO - PROCESS | 1996 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:07:07 INFO - PROCESS | 1996 | 2017-01-19 12:07:07.903 plugin-container[1997:280164] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.CFPasteboardClient' 12:07:07 INFO - PROCESS | 1996 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:07:07 INFO - PROCESS | 1996 | 2017-01-19 12:07:07.903 plugin-container[1997:280164] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:07:17 INFO - PROCESS | 1996 | RSS: Main: 228958208 12:07:17 INFO - PROCESS | 1996 | 12:07:20 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49305/tests/kraken/driver.html?testName=audio-beat-detection) 12:07:21 INFO - PROCESS | 1996 | RSS: Main: 241831936 12:07:21 INFO - PROCESS | 1996 | 12:07:24 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49305/tests/kraken/driver.html?testName=audio-dft) 12:07:24 INFO - PROCESS | 1996 | RSS: Main: 249442304 12:07:24 INFO - PROCESS | 1996 | 12:07:28 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49305/tests/kraken/driver.html?testName=audio-fft) 12:07:28 INFO - PROCESS | 1996 | RSS: Main: 251265024 12:07:28 INFO - PROCESS | 1996 | 12:07:30 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49305/tests/kraken/driver.html?testName=audio-oscillator) 12:07:31 INFO - PROCESS | 1996 | RSS: Main: 253898752 12:07:31 INFO - PROCESS | 1996 | 12:07:33 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49305/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:07:34 INFO - PROCESS | 1996 | RSS: Main: 254222336 12:07:34 INFO - PROCESS | 1996 | 12:07:37 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49305/tests/kraken/driver.html?testName=imaging-darkroom) 12:07:37 INFO - PROCESS | 1996 | RSS: Main: 258162688 12:07:37 INFO - PROCESS | 1996 | 12:07:41 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49305/tests/kraken/driver.html?testName=imaging-desaturate) 12:07:41 INFO - PROCESS | 1996 | RSS: Main: 257626112 12:07:41 INFO - PROCESS | 1996 | 12:07:44 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49305/tests/kraken/driver.html?testName=json-parse-financial) 12:07:45 INFO - PROCESS | 1996 | RSS: Main: 257470464 12:07:45 INFO - PROCESS | 1996 | 12:07:46 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49305/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:07:47 INFO - PROCESS | 1996 | RSS: Main: 256704512 12:07:47 INFO - PROCESS | 1996 | 12:07:49 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:07:50 INFO - PROCESS | 1996 | RSS: Main: 256753664 12:07:50 INFO - PROCESS | 1996 | 12:07:52 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:07:53 INFO - PROCESS | 1996 | RSS: Main: 256774144 12:07:53 INFO - PROCESS | 1996 | 12:07:56 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:07:57 INFO - PROCESS | 1996 | RSS: Main: 256995328 12:07:57 INFO - PROCESS | 1996 | 12:07:59 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:08:00 INFO - PROCESS | 1996 | RSS: Main: 256831488 12:08:00 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49305/tests/kraken/driver.html?testName=ai-astar) 12:08:02 INFO - PROCESS | 1996 | RSS: Main: 258895872 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | __start_tp_report 12:08:02 INFO - PROCESS | 1996 | _x_x_mozilla_page_load 12:08:02 INFO - PROCESS | 1996 | _x_x_mozilla_page_load_details 12:08:02 INFO - PROCESS | 1996 | |i|pagename|runs| 12:08:02 INFO - PROCESS | 1996 | |0;ai-astar;113;126;118;173;161;119;123;173;131;123 12:08:02 INFO - PROCESS | 1996 | |1;audio-beat-detection;148;113;115;154;135;115;118;113;154;148 12:08:02 INFO - PROCESS | 1996 | |2;audio-dft;284;202;275;232;282;265;200;198;198;204 12:08:02 INFO - PROCESS | 1996 | |3;audio-fft;79;73;52;77;63;85;85;87;81;51 12:08:02 INFO - PROCESS | 1996 | |4;audio-oscillator;105;70;82;67;68;70;86;70;71;88 12:08:02 INFO - PROCESS | 1996 | |5;imaging-gaussian-blur;90;88;127;98;136;86;137;132;116;88 12:08:02 INFO - PROCESS | 1996 | |6;imaging-darkroom;96;106;145;97;107;155;123;153;151;103 12:08:02 INFO - PROCESS | 1996 | |7;imaging-desaturate;90;93;127;88;131;136;91;89;103;90 12:08:02 INFO - PROCESS | 1996 | |8;json-parse-financial;56;56;57;57;62;62;62;61;60;61 12:08:02 INFO - PROCESS | 1996 | |9;json-stringify-tinderbox;69;71;81;72;77;84;104;108;72;72 12:08:02 INFO - PROCESS | 1996 | |10;stanford-crypto-aes;84;85;84;76;73;101;109;107;99;109 12:08:02 INFO - PROCESS | 1996 | |11;stanford-crypto-ccm;138;161;164;140;166;159;169;161;213;165 12:08:02 INFO - PROCESS | 1996 | |12;stanford-crypto-pbkdf2;173;173;171;170;173;170;166;175;188;168 12:08:02 INFO - PROCESS | 1996 | |13;stanford-crypto-sha256-iterative;79;92;74;67;63;82;85;88;91;91 12:08:02 INFO - PROCESS | 1996 | __end_tp_report 12:08:02 INFO - PROCESS | 1996 | __start_cc_report 12:08:02 INFO - PROCESS | 1996 | _x_x_mozilla_cycle_collect,955 12:08:02 INFO - PROCESS | 1996 | __end_cc_report 12:08:02 INFO - PROCESS | 1996 | __startTimestamp1484856482717__endTimestamp 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | ------- Summary: start ------- 12:08:02 INFO - PROCESS | 1996 | Number of tests: 14 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#0] ai-astar Cycles:10 Average:136.00 Median:128.50 stddev:23.49 (18.3%) stddev-sans-first:23.40 12:08:02 INFO - PROCESS | 1996 | Values: 113.0 126.0 118.0 173.0 161.0 119.0 123.0 173.0 131.0 123.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:141.50 stddev:18.20 (12.9%) stddev-sans-first:18.27 12:08:02 INFO - PROCESS | 1996 | Values: 148.0 113.0 115.0 154.0 135.0 115.0 118.0 113.0 154.0 148.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#2] audio-dft Cycles:10 Average:234.00 Median:248.50 stddev:38.18 (15.4%) stddev-sans-first:35.96 12:08:02 INFO - PROCESS | 1996 | Values: 284.0 202.0 275.0 232.0 282.0 265.0 200.0 198.0 198.0 204.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#3] audio-fft Cycles:10 Average:73.30 Median:80.00 stddev:13.43 (16.8%) stddev-sans-first:14.09 12:08:02 INFO - PROCESS | 1996 | Values: 79.0 73.0 52.0 77.0 63.0 85.0 85.0 87.0 81.0 51.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:70.50 stddev:12.34 (17.5%) stddev-sans-first:8.23 12:08:02 INFO - PROCESS | 1996 | Values: 105.0 70.0 82.0 67.0 68.0 70.0 86.0 70.0 71.0 88.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:87.00 stddev:21.86 (25.1%) stddev-sans-first:21.98 12:08:02 INFO - PROCESS | 1996 | Values: 90.0 88.0 127.0 98.0 136.0 86.0 137.0 132.0 116.0 88.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#6] imaging-darkroom Cycles:10 Average:123.60 Median:152.00 stddev:24.81 (16.3%) stddev-sans-first:24.22 12:08:02 INFO - PROCESS | 1996 | Values: 96.0 106.0 145.0 97.0 107.0 155.0 123.0 153.0 151.0 103.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#7] imaging-desaturate Cycles:10 Average:103.80 Median:89.50 stddev:19.57 (21.9%) stddev-sans-first:20.11 12:08:02 INFO - PROCESS | 1996 | Values: 90.0 93.0 127.0 88.0 131.0 136.0 91.0 89.0 103.0 90.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:61.00 stddev:2.59 (4.2%) stddev-sans-first:2.44 12:08:02 INFO - PROCESS | 1996 | Values: 56.0 56.0 57.0 57.0 62.0 62.0 62.0 61.0 60.0 61.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#9] json-stringify-tinderbox Cycles:10 Average:81.00 Median:72.00 stddev:14.02 (19.5%) stddev-sans-first:14.19 12:08:02 INFO - PROCESS | 1996 | Values: 69.0 71.0 81.0 72.0 77.0 84.0 104.0 108.0 72.0 72.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:80.00 stddev:13.83 (17.3%) stddev-sans-first:14.31 12:08:02 INFO - PROCESS | 1996 | Values: 84.0 85.0 84.0 76.0 73.0 101.0 109.0 107.0 99.0 109.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#11] stanford-crypto-ccm Cycles:10 Average:163.60 Median:164.50 stddev:20.34 (12.4%) stddev-sans-first:19.35 12:08:02 INFO - PROCESS | 1996 | Values: 138.0 161.0 164.0 140.0 166.0 159.0 169.0 161.0 213.0 165.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.00 stddev:6.00 (3.5%) stddev-sans-first:6.36 12:08:02 INFO - PROCESS | 1996 | Values: 173.0 173.0 171.0 170.0 173.0 170.0 166.0 175.0 188.0 168.0 12:08:02 INFO - PROCESS | 1996 | 12:08:02 INFO - PROCESS | 1996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.20 Median:86.50 stddev:10.33 (11.9%) stddev-sans-first:10.92 12:08:02 INFO - PROCESS | 1996 | Values: 79.0 92.0 74.0 67.0 63.0 82.0 85.0 88.0 91.0 91.0 12:08:02 INFO - PROCESS | 1996 | -------- Summary: end -------- 12:08:02 INFO - PROCESS | 1996 | 12:08:03 INFO - TEST-INFO | 1996: exit 0 12:08:03 INFO - TEST-OK | kraken | took 62728ms 12:08:03 INFO - SUITE-END | took 1177s 12:08:03 INFO - Completed test suite (00:19:38) 12:08:03 INFO - javascript benchmark 12:08:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7026.623489001344, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2726.236653736954, 2860.6567211934566, 3263.3636440894034, 3272.869085236589, 3275.5905511811025, 5410.215518749779, 5456.727163641812, 5468.152436372364, 5483.232347471348, 5551.611387202897, 4608.53914608539, 5426.023315803154, 5553.750081246343, 5594.992901277768, 5610.214569960209, 5043.747812609364, 5092.745362731848, 5139.768710408022, 5152.768125434364, 5159.277701121827, 4480.283154695249, 4909.803607855682, 5103.8468845934685, 5171.250168725533, 5205.0, 4870.65905386623, 4899.069176856386, 5138.460461651529, 5142.177251639739, 5163.32876726027, 4955.975220123913, 4964.180910149821, 5041.823536176216, 5103.795848166069, 5127.76942030218, 5044.747762611854, 5053.140966035783, 5058.620603454756, 5058.848234552969, 5077.593792496591, 5523.751431185607, 5561.443855614447, 5643.125315576092, 5649.661020338752, 5651.378348381675, 5875.588708790387, 5944.702764861783, 6031.668258245794, 6045.848853778647, 6074.757009719606, 6102.96948515259, 6118.204633397674, 6132.356102609207, 6154.230721159855, 6156.7537298508005, 5331.760070796746, 5639.15412688096, 5642.576806739511, 5653.547716182778, 5656.943430565641, 5965.105234214816, 6036.245469316335, 6045.153678485016, 6054.364291749391, 6123.081537769282, 5865.20819689345, 5920.289565252111, 5928.170056192136, 5954.136650185699, 5966.492848107872, 6068.8786224276155, 6069.9089513656445, 6077.027675571887, 6079.05774604937, 6087.9391206087375, 5606.074997625427, 5682.715864206773, 5937.228160339215, 5942.37605051472, 6031.336552979169, 5733.913991290134, 5756.539476841843, 5819.127130930395, 5867.941320586825, 5895.35151133375, 4806.49531799163, 4810.59109975649, 4823.975880120577, 4831.99999999993, 4849.587785038311, 4263.040815816478, 4284.55012223712, 4303.2469317869245, 4304.892377690583, 4333.133373325348, 5233.319668443078, 5280.815171469057, 5387.4073851876265, 5522.22688823557, 5572.749226284745, 5369.7583608737705, 5931.614445061144, 6012.729427175787, 6086.1175129606845, 6110.984061328523, 5260.605454590921, 5344.144936810092, 5488.56091512678, 5603.579731520153, 5612.242347283146, 5226.111561034633, 5239.214117882349, 5247.895042099213, 5265.157574788015, 5356.678599284055, 4344.587264209895, 5385.219143224211, 5845.41545845412, 6297.685115744194, 6323.525735569759, 6014.127951447103, 6048.727807248596, 6097.725602347817, 6148.077788331786, 6148.815535533941, 4701.811927522861, 5222.2688823565495, 6258.030005349178, 6277.1525844010475, 6292.622442653455, 4574.382458368078, 6016.42843929826, 6016.759329626766, 6024.819255422344, 6029.4874935629205, 5727.455891690282, 5991.64050156992, 6039.577229593886, 6063.878722425615, 6110.224634763573, 4888.364512613338, 5731.254936858182, 5893.204417403767, 5897.705114744332, 5901.114832775118, 5784.537237021113, 5817.738201780845, 5824.796132135524, 5839.386864379179, 5845.503132233808, 5412.75642596092, 5455.290812194389, 5466.180072989084, 5612.5509959202345, 5613.747381367766, 5765.0, 5772.7690892363835, 5811.82564523065, 5817.214676018683, 5823.912641310299, 5647.040003199548, 5656.519195868233, 5664.631798933056, 5673.234113394804, 5675.545956323567], "value": 5444.437912867084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.1642692434391, 477.16496131769395, 480.50747983317075, 517.9666565202422, 531.6942757914198, 33854.66145338549, 39225.019374515614, 41284.17431651365, 41316.17367652645, 41443.79278103613, 41545.792271038605, 42163.0, 42251.36622950658, 42297.36553951685, 42350.15299694004, 7938.0, 9368.625254989793, 9481.71554853352, 9496.0, 9507.619695212183, 9266.490343031131, 9342.532873356338, 9379.671711490098, 9385.906140938605, 9423.434593924387, 9359.391639543443, 9377.859332110023, 9410.858837117414, 9431.575579098957, 9435.528223588828, 9324.300677449184, 9376.0, 9376.296777741696, 9390.62437502499, 9396.953015234949, 9346.719598412059, 9385.202257808094, 9394.95302523483, 9428.952855235748, 9439.905600943972, 40469.19061618781, 40709.77870663885, 40815.387769183486, 40853.59146408557, 40946.79526602348, 3453.8791142309897, 3514.139035936212, 3775.6601905828334, 3915.1599097191292, 3977.7414468059483, 24959.62560561593, 29615.0, 29960.8501957491, 31617.367652647048, 31898.362032759214, 3073.938521229585, 3152.9684703153134, 3208.614966204047, 3238.3685181389637, 3327.2014716468116, 440700.59299407236, 465725.0141247884, 490139.99999999645, 491982.0, 492532.0, 59248.407515924286, 59870.401295986485, 59942.700286498286, 60017.99999999913, 60399.69800151059, 54189.1871621926, 60328.39671603315, 65214.34785652083, 65390.0, 65489.67255163693, 16198.514044578682, 16238.75641865373, 16421.835781642032, 16457.670846583, 16467.258973346226, 12312.076594255466, 12552.623421297192, 12585.496580136874, 12683.365831708377, 12694.857462828206, 18189.0, 18350.082495875155, 18401.3559525416, 18407.171677274553, 18550.0, 5984.461398474158, 6755.49333799967, 6865.794026179223, 6959.3463431698765, 7005.614691191931, 865.3164000439708, 947.7772723409993, 1014.7006633043122, 1024.6516184497157, 1105.4638500327335, 23414.414639634146, 29062.70937290642, 29585.0, 30061.398772024437, 30648.387032259678, 854.8546747053016, 1052.8578641883248, 1056.894310568937, 1116.3023110555903, 1146.1919346860443, 13278.402471888789, 15951.840481595267, 16728.0, 16866.560762509976, 17250.827491725173, 552729.0, 670975.0, 673697.6315118491, 675542.0, 677195.0, 58234.0, 58798.11802822961, 58889.0, 59322.70338648279, 59361.406385936454, 1324.1326930860303, 1347.2320777157122, 1362.7206422683325, 1362.8228330316995, 1366.0983750724672, 30429.239269018453, 30910.0726978191, 31704.524432133996, 31885.36229275448, 32251.0, 52274.0, 55385.892282154935, 57035.0, 57084.714576428516, 60284.69857650684, 586414.0, 590846.0, 592272.038639804, 592285.0, 593986.0, 26380.0, 26708.599371009837, 26729.0, 26759.464810704067, 26805.597916030885, 46532.7673361631, 46850.76574617105, 47427.0, 47725.04549909052, 48235.517644824504, 38652.45390184361, 38756.6124338753, 39680.2063958725, 39898.411682656864, 40964.1807163861, 26880.32799180036, 34040.65959340474, 38997.2200555993, 39772.60227397689, 40008.39966401428, 37682.62317376791, 38278.808605956794, 38572.421413678254, 38624.03439914025, 39051.0, 31991.360172796878, 33133.0, 34466.0, 35087.29825403529, 35284.47073293954, 25723.170451249975, 25811.612825807253, 25858.0, 25899.223023309332, 26259.0], "value": 19920.754760496482, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.37121684672786, 332.35025525098433, 378.235963354025, 386.0483907168828, 400.80959550136083, 17322.653546929054, 18457.53856153597, 19989.100490477944, 20031.298904538344, 20253.291134810286, 19542.90228548855, 19659.5085122872, 19946.40160795175, 20243.190272389085, 20458.0, 5365.570754339644, 5581.302337207849, 5583.944160558383, 5597.020521408757, 5606.046972014768, 5350.732463376835, 5642.15367694847, 5658.688772117532, 5711.971440142815, 5712.857178570527, 4754.524547545252, 4756.952430475685, 5108.259302401149, 5439.374471935718, 5668.659880407189, 4381.3647021181905, 4843.24929635907, 5543.113101903697, 5592.944070559323, 5597.104463285896, 4613.6620380089735, 4679.812807487697, 4932.8520144395725, 4958.578520825698, 4969.0, 20884.686729699068, 22461.21385751507, 25142.49715005708, 25283.367915802253, 25296.747032529805, 2188.5075857931997, 2269.1490690990877, 2449.497852940143, 2466.9136580219606, 3017.215523963785, 14548.636284092876, 14912.925435372754, 14926.40294388223, 14964.551063468114, 15904.920475397665, 1811.9547011324692, 1842.97235541467, 1928.701051337045, 1931.0923865783059, 1954.7067939809, 115525.4223728876, 116824.0, 119589.80410195874, 119788.40105799503, 120618.3969080149, 11299.039581635489, 11394.031507321804, 11599.304041757352, 11651.126165537618, 11822.704432389259, 14505.927470362582, 14667.266636668124, 14676.55970320892, 14677.119372837664, 14704.926475367769, 8204.343652507785, 8476.194761497647, 8499.74500764978, 8560.61477233526, 8605.569721513899, 8350.373721970876, 8368.3305335573, 8392.748217553482, 8440.071592124861, 8498.23515883561, 4452.844150454718, 4478.216312145361, 4527.4340707411575, 4554.248548989446, 4579.793909274024, 1877.9248830046918, 1910.6274276515946, 1935.5935253596622, 1977.525393905481, 1984.4443555804398, 361.69617521281725, 370.76085924578496, 405.41012826337607, 811.2131232704268, 927.4296307770808, 11683.532658693726, 11736.94131529354, 11772.587959421551, 11790.587329443428, 11938.701532461759, 436.7314101827353, 807.4872455990488, 888.6623083228332, 912.7854954085784, 972.8297547929226, 9930.950345248228, 10904.182186336056, 10933.343999359904, 10944.781104378028, 10947.0, 607902.0, 614215.0, 621437.0, 623560.0, 624856.0, 113553.0, 131682.68317316895, 132540.3372983129, 135586.0, 139440.30279848535, 950.6767698982379, 968.7142293023575, 992.2161492420906, 994.229472159068, 1007.6473234367912, 12656.936715316364, 18423.907880460512, 19532.511687207367, 19582.412527623623, 19848.603027939072, 55894.44105559055, 56135.71932140313, 57140.0, 57734.13398798937, 59278.70360648169, 84349.57825210835, 86124.13875861162, 86219.27561448861, 87525.0, 88349.55825220833, 6843.486738494533, 7961.641726122222, 7969.282764551218, 8020.679172833022, 8254.711085111992, 10958.726031849268, 12030.819537706766, 12645.0, 12848.935755321538, 13030.47878084866, 9911.45486998222, 10833.512491937725, 11132.833007505056, 11450.599229027277, 11501.53993840237, 8291.95854020726, 9958.651447199314, 10453.843192352273, 11154.996050355507, 11209.719757005814, 9485.620575176916, 11378.260413073123, 11609.0, 11610.6516804496, 11741.823872642088, 6773.288804675438, 7967.123616402307, 7977.641006154621, 8058.99262592176, 8325.25072743456, 9979.950100249453, 10131.341462804894, 10182.847257291294, 10452.738681532719, 11158.386288754196], "value": 9190.3487927238, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.0760267230312, 1492.8283247426546, 1667.374734474572, 1771.9114044297783, 1824.8083951185117, 7521.811954701136, 7815.257550532705, 8130.105688374281, 8538.786530336736, 8583.914160858389, 7123.252058533857, 8053.355731541477, 8293.709720159795, 8467.0, 8477.576121193946, 2023.6340470182568, 2037.5822956293923, 2296.2537175418015, 2298.6207275799475, 2354.1289722802585, 2230.431240033789, 2334.6147885598857, 2393.9162129325478, 2396.4727759892794, 2399.076355603088, 2310.341552657493, 2324.6280595104786, 2348.1077190667525, 2363.432776133724, 2366.2546297916188, 2325.360525855386, 2330.067972810872, 2346.6245400735884, 2348.213348528245, 2350.2009316832273, 2352.3178278299274, 2367.30164601443, 2373.3947843299848, 2376.370261880603, 2384.332386931662, 8432.789180270482, 8463.619137138843, 8506.787330316729, 8517.318614510887, 8529.658813647447, 4294.720843145217, 5244.8688782780355, 5255.789768409259, 5264.9733302006125, 5268.157094864841, 3342.565466489341, 3456.274182421669, 3594.029612004744, 3616.7649102808496, 3661.4690869823726, 871.4030888841164, 1032.958681652733, 1071.9732006699817, 1104.6741211342594, 1111.0722546673537, 9182.26541876655, 10961.506732196991, 11024.50389732464, 11027.944860275808, 11062.39156846373, 4526.7283962961665, 4633.166030114544, 4700.905981880412, 4733.881652958635, 4775.928361074587, 7948.642311096015, 8287.715404112372, 9126.13301736334, 9500.904990950141, 9592.472414017297, 5254.816081437208, 5265.815696450606, 5270.92093618596, 5278.261043453919, 5294.126469132627, 4097.672186225095, 4785.976070119627, 4850.078485087893, 4850.53919877611, 4870.537298956593, 3830.731848770615, 3832.405977073558, 3912.68698504119, 3930.371140617545, 3948.9605103949166, 1273.4651446392538, 1291.5285920639087, 1293.9805902911464, 1301.342821874966, 1304.2891624064907, 807.4832107451236, 881.5680316644798, 901.677516522501, 912.6896855069308, 927.8793756811572, 5566.165075238747, 5777.855553611109, 5866.765329386777, 5904.468597826216, 5915.822525324161, 897.9146981036922, 917.3486824354783, 923.1230331185401, 930.6184464369576, 966.6665000574791, 3756.9060773480337, 3836.635519625687, 3861.5945325740954, 3906.374980003186, 3939.7392834293323, 9944.80110397788, 10474.423906685206, 10487.632932847466, 10506.579736810441, 10515.52680129396, 10407.959204079683, 10429.739256518496, 10451.790964180675, 10477.161827053817, 10480.213983951235, 6635.966820165868, 7655.885161722578, 8009.7997550060545, 8018.639161237758, 8032.1164671886045, 5534.4742249486235, 5598.1322894951345, 5700.572457065819, 5730.799422020376, 5756.798512052058, 7826.0, 8511.787205319917, 9546.522673866419, 9703.272254580794, 9732.46471444049, 9420.62317507292, 9482.525873706149, 9649.807003860024, 9700.514974251118, 9743.074407931235, 7196.388306993964, 7398.038255026812, 7704.8459030820195, 7853.175416581176, 8024.719134830487, 7939.364850811806, 8163.142869998802, 8192.344612430872, 8203.71287004952, 8215.835683286421, 7127.180374257026, 7191.316824901626, 7213.567185968858, 7370.115586129698, 7377.372923301579, 6999.440044796303, 7068.752593659197, 7101.893471597827, 7201.207867134715, 7217.494775365884, 6811.829704257235, 6825.453963682993, 6878.518503704692, 6886.035954966209, 6896.586204827727, 4866.419322635066, 4918.0901533216465, 4957.603391728725, 5004.974975125101, 5005.0, 4687.718736875799, 4869.537393947569, 4906.411230652202, 4928.704277743347, 5022.121128802518], "value": 4468.363592733258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.3460778640274, 291.7869954932899, 304.0847050378361, 307.3928990244269, 307.99900323947173, 4387.3418987151945, 4409.470863496377, 4783.976080119599, 5139.922901156481, 5192.844214673556, 4268.57314268573, 4268.679849011329, 5000.374878164602, 5153.76808043638, 5207.3490813648295, 3819.885403437894, 3893.299206142893, 3936.9960660031793, 3987.9800600996955, 4026.2953983052994, 3704.092497338156, 4003.519577650686, 4039.141994682435, 4039.596040395966, 4041.2321658884716, 3691.4093745000805, 3911.8630847920326, 3930.430087637291, 3937.9015524611827, 3944.408338749182, 3157.6842315768467, 3463.839613729416, 3949.7037722170808, 3950.407438884162, 3959.425883246913, 2969.940601187964, 3446.362422951762, 3461.6365281645317, 3467.271872906693, 3480.112571294329, 4001.7198796084285, 4838.274258861164, 4881.292212629149, 4972.353594032753, 4997.400311962588, 4498.415206023229, 4521.751303678297, 4522.241432726035, 4524.389207456984, 4526.547345265447, 4562.954370456286, 5445.9727701361635, 5491.093969495028, 5491.917621235645, 5501.626207165274, 3283.96716032839, 3624.151682641845, 3757.1922036761953, 3787.3750831112834, 3791.1233939199997, 4751.97832466018, 4806.78369473371, 5137.537621614073, 5724.484796368305, 5728.283964504437, 3770.9057273567832, 3797.7911214883447, 3800.7149463790324, 3803.904902377463, 3820.6179382061573, 3703.8147792706613, 3851.1527463957887, 3872.7869967151514, 3892.163184915257, 3894.8120823148647, 3909.4722212501515, 4083.5916408358926, 4303.397524346594, 4413.889652758707, 4464.687471877002, 4799.688020278671, 5488.341399032141, 5495.890082198413, 5531.115021596525, 5548.639338443069, 1079.3216548267362, 1151.746615744535, 1174.5142394870495, 1187.7446349035, 1248.7627350803318, 829.2122483640566, 843.4264700004056, 857.2584714222153, 859.7034023261965, 862.6118246788844, 4452.777361131931, 4784.952150478521, 4902.034269267042, 4951.554360107608, 4956.5786908112495, 4880.292357608198, 5152.819651312186, 5365.892682146336, 5376.0, 5408.621396502207, 4223.894402639897, 4633.0, 4669.883252918704, 4813.302071199656, 4931.260310953386, 2553.812477198112, 2753.9586906196423, 2765.308672831792, 2783.5685468752376, 2800.957985630217, 4802.855914322576, 5411.4036359274105, 5428.70142142186, 5459.808906688327, 5461.9453805462235, 4402.757848318373, 4502.032063106382, 4898.81576974962, 5125.666831655931, 5375.9462405376225, 4695.886850917101, 5316.6872410501555, 5326.520613144836, 5435.602748282324, 5472.878059997771, 4340.85288166077, 4864.713584615225, 5288.312519372611, 5331.0, 5356.303680521663, 4171.416001759695, 4574.565416285448, 4630.663688576877, 5210.374755029421, 5272.44639312882, 4431.955680443283, 4524.253498172896, 5299.947000529945, 5463.808766693147, 5467.480589344006, 3248.3503299339754, 3346.1300061983575, 3537.9292414152087, 3569.464580312974, 3616.571454275494, 4050.67594592426, 4859.586935110555, 4977.502249774993, 5227.032998895216, 5307.4692530746615, 4670.392848929753, 5536.141898005815, 5605.729679479818, 5620.269364982526, 5624.5376202188545, 5586.832395028156, 5600.27196464457, 5613.522850557748, 5617.494425501724, 5639.661620302795, 4460.687751857339, 4514.819407223675, 5249.900039983884, 5413.347459744776, 5436.565074793928, 4368.781560921878, 5481.260029895913, 5554.944450555443, 5562.2490963721, 5594.580406469449, 5445.40100588927, 5462.8361149165585, 5472.863178420572, 5507.972460137674, 5524.4199359068325], "value": 3871.7781151326753, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.8585565219995, 614.6342925959053, 681.6864242448473, 689.369227157151, 726.9818254543636, 14092.577222683323, 14856.554303370916, 14867.851321486782, 14876.925615371922, 14886.0, 13104.213747175152, 13227.338633068332, 13252.403641836116, 13270.469181232738, 13290.534831280907, 634.0679201573679, 657.6317262333085, 788.2078511096369, 807.5598798654732, 823.0288259853371, 718.3032458515232, 799.7041094794905, 816.677412422093, 820.729159377404, 823.8013690080918, 872.7992561710811, 874.6938571499987, 874.846901792187, 874.8512752832033, 877.2937785083005, 835.3985130705883, 862.0043849354006, 870.0646804684957, 871.8735783311448, 871.9869201961976, 635.2567496029657, 636.9681515924185, 644.8678021005683, 645.2805122288614, 645.4352441613588, 14115.060827858491, 14454.638634034232, 14455.494057708034, 14569.562913112624, 14592.562223133324, 11361.829572556418, 13408.86591134086, 13595.728085438235, 13835.100718453268, 13973.650658733512, 9307.208887244524, 10444.634437794717, 11083.445827708663, 11205.461787975883, 11214.66356009321, 4330.610245077958, 4337.306031035019, 4370.737755734666, 4382.123575284924, 4445.088756804847, 83652.58173709092, 83924.74112888312, 84664.0, 85567.71648425279, 87305.0, 8631.180037896389, 10063.496825158712, 10127.189824813997, 10197.898021019842, 10226.335288206243, 18879.62240755177, 18905.432837014912, 19053.04734763284, 19058.90470547666, 19213.711794323095, 7101.786946391617, 7195.676194571257, 7240.275972402717, 7346.265373462611, 7365.963170184222, 4078.347464405681, 4172.4784401949755, 4177.8328866845595, 4181.749095054306, 4183.832646694098, 3178.173674844511, 3242.2866969266724, 3275.082976766509, 3283.1627934876456, 3287.901362959115, 615.2678312807744, 626.5927147354256, 628.3904612525843, 629.3643420145594, 639.0254861336406, 478.3255609590461, 484.63894398673216, 494.97030178189425, 541.6939429222476, 581.430198405565, 7170.6056166910275, 7898.526088434713, 8228.0, 8511.467935771496, 8703.564821758886, 534.5376249544116, 578.5574035862569, 588.5732843688377, 591.5949619653323, 620.8230654263604, 4057.5739547347694, 4230.450041494586, 4257.829686812493, 4267.935980960288, 4290.059387802878, 75918.0, 76344.85482717764, 79049.0, 117058.41470792591, 127315.0, 41937.16125677469, 66977.6651116751, 78404.60797695976, 81098.59450702826, 87209.56395217983, 72151.6392418045, 81748.59125704452, 91795.0, 94120.58819117719, 94177.529112354, 8717.953845538575, 9268.768280793034, 9280.0, 9281.211097056826, 9300.674476393564, 42047.57952420559, 43193.3520997179, 52953.47046529486, 56011.719941400035, 57685.42314576801, 27894.60526973684, 29590.556141658322, 68437.65781171063, 77197.0, 80237.19762802531, 11988.700282492659, 12026.27842329463, 12226.633201003984, 12392.442340094898, 12673.30296833683, 13367.665808354868, 13483.528076517276, 13840.169589824643, 13919.373628186553, 14163.433462661378, 12251.264924104582, 12797.552085676956, 13178.868211317764, 13633.250171240677, 13679.521216757366, 12273.35147686671, 12985.610431687064, 13134.408951597392, 13492.865071349554, 13555.525556605471, 11758.221021581789, 13170.143940643828, 13192.538261160813, 13554.25451600132, 13607.591772246848, 10274.897251027693, 10468.738281543023, 11363.886361136283, 11451.885481145082, 11486.540538378706, 10572.36565806054, 11185.944070279596, 11192.552297908318, 11408.486618102039, 11448.255863368855], "value": 6978.799780011361, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1640.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 126.0, 118.0, 173.0, 161.0, 119.0, 123.0, 173.0, 131.0, 123.0], "value": 136.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 115.0, 154.0, 135.0, 115.0, 118.0, 113.0, 154.0, 148.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [284.0, 202.0, 275.0, 232.0, 282.0, 265.0, 200.0, 198.0, 198.0, 204.0], "value": 234.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 52.0, 77.0, 63.0, 85.0, 85.0, 87.0, 81.0, 51.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 70.0, 82.0, 67.0, 68.0, 70.0, 86.0, 70.0, 71.0, 88.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 127.0, 98.0, 136.0, 86.0, 137.0, 132.0, 116.0, 88.0], "value": 109.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 106.0, 145.0, 97.0, 107.0, 155.0, 123.0, 153.0, 151.0, 103.0], "value": 123.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 127.0, 88.0, 131.0, 136.0, 91.0, 89.0, 103.0, 90.0], "value": 103.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 62.0, 62.0, 62.0, 61.0, 60.0, 61.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 81.0, 72.0, 77.0, 84.0, 104.0, 108.0, 72.0, 72.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 76.0, 73.0, 101.0, 109.0, 107.0, 99.0, 109.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 161.0, 164.0, 140.0, 166.0, 159.0, 169.0, 161.0, 213.0, 165.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 171.0, 170.0, 173.0, 170.0, 166.0, 175.0, 188.0, 168.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 92.0, 74.0, 67.0, 63.0, 82.0, 85.0, 88.0, 91.0, 91.0], "value": 81.2, "unit": "score"}]}]} 12:08:03 INFO - Return code: 0 12:08:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:08:04 ERROR - # TBPL SUCCESS # 12:08:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:08:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:08:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:08:04 INFO - 2017-01-19 12:08:04.017 screenresolution[2001:280545] starting screenresolution argv=screenresolution get 12:08:04 INFO - 2017-01-19 12:08:04.020 screenresolution[2001:280545] Display 0: 1600x1200x32@60 12:08:04 INFO - 2017-01-19 12:08:04.026 screenresolution[2002:280548] starting screenresolution argv=screenresolution list 12:08:04 INFO - Available Modes on Display 0 12:08:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:08:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:08:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:08:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:08:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:08:04 INFO - Intel Iris: 12:08:04 INFO - Chipset Model: Intel Iris 12:08:04 INFO - Type: GPU 12:08:04 INFO - Bus: Built-In 12:08:04 INFO - VRAM (Dynamic, Max): 1536 MB 12:08:04 INFO - Vendor: Intel (0x8086) 12:08:04 INFO - Device ID: 0x0a2e 12:08:04 INFO - Revision ID: 0x0009 12:08:04 INFO - Displays: 12:08:04 INFO - Display: 12:08:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:08:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:08:04 INFO - Display Serial Number: 1600x1200 60 12:08:04 INFO - Main Display: Yes 12:08:04 INFO - Mirror: Off 12:08:04 INFO - Online: Yes 12:08:04 INFO - Rotation: Supported 12:08:04 INFO - Return code: 0 12:08:04 INFO - Running post-action listener: _resource_record_post_action 12:08:04 INFO - [mozharness: 2017-01-19 20:08:04.273135Z] Finished run-tests step (success) 12:08:04 INFO - Running post-run listener: _resource_record_post_run 12:08:04 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 9561088; Write bytes: 660001280; Read time: 89; Write time: 1928 12:08:04 INFO - TinderboxPrint: CPU usage
54.2% 12:08:04 INFO - TinderboxPrint: I/O read bytes / time
9,561,088 / 89 12:08:04 INFO - TinderboxPrint: I/O write bytes / time
660,001,280 / 1,928 12:08:04 INFO - TinderboxPrint: CPU idle
2,219.2 (45.8%) 12:08:04 INFO - TinderboxPrint: CPU system
976.4 (20.2%) 12:08:04 INFO - TinderboxPrint: CPU user
1,646.2 (34.0%) 12:08:04 INFO - TinderboxPrint: Swap in / out
368,242,688 / 0 12:08:04 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 338776576; Write bytes: 333301248; Read time: 26837; Write time: 731 12:08:04 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 9561088; Write bytes: 308976640; Read time: 89; Write time: 1143 12:08:04 INFO - Running post-run listener: _upload_blobber_files 12:08:04 INFO - Blob upload gear active. 12:08:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:08:04 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 12:08:04 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:08:04 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:08:05 INFO - (blobuploader) - INFO - Open directory for files ... 12:08:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:08:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:08:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:05 INFO - (blobuploader) - INFO - Done attempting. 12:08:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:08:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:08:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:07 INFO - (blobuploader) - INFO - Done attempting. 12:08:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:08:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:08:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:09 INFO - (blobuploader) - INFO - Done attempting. 12:08:09 INFO - (blobuploader) - INFO - Iteration through files over. 12:08:09 INFO - Return code: 0 12:08:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:08:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:08:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0267358f9349c722218fa53881cd553eefdd51b381bbb8ccce8c666e6098e957f5117f52d05e80b0018c1cbe42fc4677e937c007ab029f876840388ee011d075", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff173827b05e2a93dbcaf1a3f18ec0fef7cb1929428ef982d9e9870eb782f19b3a3899094ca68721e35036a32e634ab2d67cb198e73ac09df453963e9f1307af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d8baaffb36e4e09c9d113ee1855f9c138a3d4d4f0dbc67806e54aea0bea4d343d4625df9ab8c0a94604f0b6f5a8ba7c2df5b47e84644f107c366779d61deba2"} 12:08:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:08:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:08:09 INFO - Contents: 12:08:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0267358f9349c722218fa53881cd553eefdd51b381bbb8ccce8c666e6098e957f5117f52d05e80b0018c1cbe42fc4677e937c007ab029f876840388ee011d075", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff173827b05e2a93dbcaf1a3f18ec0fef7cb1929428ef982d9e9870eb782f19b3a3899094ca68721e35036a32e634ab2d67cb198e73ac09df453963e9f1307af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d8baaffb36e4e09c9d113ee1855f9c138a3d4d4f0dbc67806e54aea0bea4d343d4625df9ab8c0a94604f0b6f5a8ba7c2df5b47e84644f107c366779d61deba2"} 12:08:09 INFO - Running post-run listener: copy_logs_to_upload_dir 12:08:09 INFO - Copying logs to upload dir... 12:08:09 INFO - mkdir: /builds/slave/test/build/upload/logs 12:08:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.685881 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-01-19 12:08:09.404826) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 12:08:09.408147) ========= 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.7es3Mw1mNS/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.x768rAJtia/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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/Mozilla-Aurora/sha512/0267358f9349c722218fa53881cd553eefdd51b381bbb8ccce8c666e6098e957f5117f52d05e80b0018c1cbe42fc4677e937c007ab029f876840388ee011d075", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff173827b05e2a93dbcaf1a3f18ec0fef7cb1929428ef982d9e9870eb782f19b3a3899094ca68721e35036a32e634ab2d67cb198e73ac09df453963e9f1307af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d8baaffb36e4e09c9d113ee1855f9c138a3d4d4f0dbc67806e54aea0bea4d343d4625df9ab8c0a94604f0b6f5a8ba7c2df5b47e84644f107c366779d61deba2"} build_url:https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/X1dRkl7kTxu1_9a_hQ9JFw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0267358f9349c722218fa53881cd553eefdd51b381bbb8ccce8c666e6098e957f5117f52d05e80b0018c1cbe42fc4677e937c007ab029f876840388ee011d075", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff173827b05e2a93dbcaf1a3f18ec0fef7cb1929428ef982d9e9870eb782f19b3a3899094ca68721e35036a32e634ab2d67cb198e73ac09df453963e9f1307af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d8baaffb36e4e09c9d113ee1855f9c138a3d4d4f0dbc67806e54aea0bea4d343d4625df9ab8c0a94604f0b6f5a8ba7c2df5b47e84644f107c366779d61deba2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 12:08:09.447653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:08:09.448442) ========= 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.7es3Mw1mNS/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.x768rAJtia/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005310 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 12:08:09.500563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 12:08:09.501351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 12:08:09.502060) ========= ========= Total master_lag: 0.21 =========