builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0068 starttime: 1483957377.64 results: success (0) buildid: 20170108234108 builduid: 61c8c2b722174db491f223ed4bcb537d revision: fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 02:22:57.643145) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 02:22:57.643874) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 28 secs) (at 2017-01-09 02:22:57.644344) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 28 secs) (at 2017-01-09 02:23:26.627411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2017-01-09 02:23:26.627659) ========= 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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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-09 02:23:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.1M=0.001s 2017-01-09 02:23:33 (13.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=6.176311 ========= master_lag: 0.60 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2017-01-09 02:23:33.399689) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 11 secs) (at 2017-01-09 02:23:33.400083) ========= 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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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.027840 ========= master_lag: 11.84 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 11 secs) (at 2017-01-09 02:23:45.263837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-01-09 02:23:45.264189) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 --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 fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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-09 02:23:45,601 truncating revision to first 12 chars 2017-01-09 02:23:45,601 Setting DEBUG logging. 2017-01-09 02:23:45,601 attempt 1/10 2017-01-09 02:23:45,601 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fed81ec38bdf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 02:23:50,590 unpacking tar archive at: mozilla-aurora-fed81ec38bdf/testing/mozharness/ program finished with exit code 0 elapsedTime=5.260249 ========= master_lag: 0.45 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-01-09 02:23:50.977892) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 02:23:50.978254) ========= script_repo_revision: fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 02:23:50.978714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 23 secs) (at 2017-01-09 02:23:50.979026) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 23 secs) (at 2017-01-09 02:24:14.873973) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 30 mins, 1 secs) (at 2017-01-09 02:24:14.874240) ========= /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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 02:24:20 INFO - MultiFileLogger online at 20170109 02:24:20 in /builds/slave/test 02:24:20 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 02:24:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:24:20 INFO - {'append_to_log': False, 02:24:20 INFO - 'base_work_dir': '/builds/slave/test', 02:24:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:24:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:24:20 INFO - 'branch': 'Mozilla-Aurora', 02:24:20 INFO - 'buildbot_json_path': 'buildprops.json', 02:24:20 INFO - 'config_files': ('talos/mac_config.py',), 02:24:20 INFO - 'default_actions': ('clobber', 02:24:20 INFO - 'read-buildbot-config', 02:24:20 INFO - 'download-and-extract', 02:24:20 INFO - 'populate-webroot', 02:24:20 INFO - 'create-virtualenv', 02:24:20 INFO - 'install', 02:24:20 INFO - 'run-tests'), 02:24:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:24:20 INFO - 'download_minidump_stackwalk': True, 02:24:20 INFO - 'download_symbols': 'ondemand', 02:24:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:24:20 INFO - 'tooltool.py': '/tools/tooltool.py', 02:24:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:24:20 INFO - '/tools/misc-python/virtualenv.py')}, 02:24:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:24:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:24:20 INFO - 'installer_path': 'installer.exe', 02:24:20 INFO - 'log_level': 'info', 02:24:20 INFO - 'log_name': 'talos', 02:24:20 INFO - 'log_to_console': True, 02:24:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:24:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:24:20 INFO - 'opt_config_files': (), 02:24:20 INFO - 'pip_index': False, 02:24:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:24:20 INFO - 'cmd': ('bash', 02:24:20 INFO - '-c', 02:24:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:24:20 INFO - 'enabled': True, 02:24:20 INFO - 'halt_on_failure': False, 02:24:20 INFO - 'name': 'check_screen_resolution'},), 02:24:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:24:20 INFO - 'cmd': ('bash', 02:24:20 INFO - '-c', 02:24:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:24:20 INFO - 'enabled': True, 02:24:20 INFO - 'halt_on_failure': False, 02:24:20 INFO - 'name': 'check_screen_resolution'},), 02:24:20 INFO - 'run_cmd_checks_enabled': True, 02:24:20 INFO - 'sps_profile': False, 02:24:20 INFO - 'sps_profile_interval': 0, 02:24:20 INFO - 'suite': 'dromaeojs-e10s', 02:24:20 INFO - 'system_bits': '32', 02:24:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:24:20 INFO - 'title': 't-yosemite-r7-0068', 02:24:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:24:20 INFO - 'use_talos_json': True, 02:24:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:24:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:24:20 INFO - 'work_dir': 'build'} 02:24:20 INFO - [mozharness: 2017-01-09 10:24:20.442661Z] Running clobber step. 02:24:20 INFO - Running pre-action listener: _resource_record_pre_action 02:24:20 INFO - Running main action method: clobber 02:24:20 INFO - rmtree: /builds/slave/test/build 02:24:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:24:22 INFO - Running post-action listener: _resource_record_post_action 02:24:22 INFO - [mozharness: 2017-01-09 10:24:22.827276Z] Finished clobber step (success) 02:24:22 INFO - [mozharness: 2017-01-09 10:24:22.827404Z] Running read-buildbot-config step. 02:24:22 INFO - Running pre-action listener: _resource_record_pre_action 02:24:22 INFO - Running main action method: read_buildbot_config 02:24:22 INFO - Using buildbot properties: 02:24:22 INFO - { 02:24:22 INFO - "project": "", 02:24:22 INFO - "product": "firefox", 02:24:22 INFO - "script_repo_revision": "production", 02:24:22 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:24:22 INFO - "repository": "", 02:24:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:24:22 INFO - "buildid": "20170108234108", 02:24:22 INFO - "pgo_build": "False", 02:24:22 INFO - "basedir": "/builds/slave/test", 02:24:22 INFO - "buildnumber": 28, 02:24:22 INFO - "slavename": "t-yosemite-r7-0068", 02:24:22 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:24:22 INFO - "platform": "yosemite_r7", 02:24:22 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:24:22 INFO - "branch": "mozilla-aurora", 02:24:22 INFO - "repo_path": "releases/mozilla-aurora", 02:24:22 INFO - "revision": "fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86", 02:24:22 INFO - "stage_platform": "macosx64", 02:24:22 INFO - "builduid": "61c8c2b722174db491f223ed4bcb537d", 02:24:22 INFO - "slavebuilddir": "test" 02:24:22 INFO - } 02:24:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:24:22 INFO - Running post-action listener: _resource_record_post_action 02:24:22 INFO - [mozharness: 2017-01-09 10:24:22.830580Z] Finished read-buildbot-config step (success) 02:24:22 INFO - [mozharness: 2017-01-09 10:24:22.830708Z] Running download-and-extract step. 02:24:22 INFO - Running pre-action listener: _resource_record_pre_action 02:24:22 INFO - Running main action method: download_and_extract 02:24:22 INFO - mkdir: /builds/slave/test/build/tests 02:24:22 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')]} 02:24:22 INFO - trying https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:24:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/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 02:24:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/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 02:24:27 INFO - Downloaded 1199 bytes. 02:24:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:24:27 INFO - Using the following test package requirements: 02:24:27 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:24:27 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:24:27 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:24:27 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:24:27 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:24:27 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:24:27 INFO - u'jsshell-mac.zip'], 02:24:27 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:24:27 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:24:27 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:24:27 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:24:27 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:24:27 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:24:27 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:24:27 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:24:27 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:24:27 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:24:27 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:24:27 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:24:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:24:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:24:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:24:28 INFO - Http code: 200 02:24:28 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 02:24:28 INFO - x-amz-cf-id: uQ3nNWCDOu8TSVngWcOrrYnc-Qqd0jB2VqY-EiAbgD_aVvlcc9EMHg== 02:24:28 INFO - x-amz-version-id: ..QJpBJvoMS2gJB8PzVp_yTknCVzZpgs 02:24:28 INFO - Expected file size: 16270960 02:24:28 INFO - Obtained file size: 16270960 02:24:35 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 02:24:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:24:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:24:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:25:08 INFO - retry: attempt #1 caught exception: 02:25:08 INFO - retry: Failed, sleeping 60 seconds before retrying 02:26:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #2 02:26:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:26:40 INFO - retry: attempt #2 caught exception: '' 02:26:40 INFO - retry: Failed, sleeping 120 seconds before retrying 02:28:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #3 02:28:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:29:14 INFO - retry: attempt #3 caught exception: '' 02:29:14 INFO - retry: Failed, sleeping 240 seconds before retrying 02:33:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #4 02:33:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:33:15 INFO - Http code: 200 02:33:15 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 02:33:15 INFO - x-amz-cf-id: O6X3S4CYZuLlct67bNr6FAUCvJoP-Vhp-U29a3j-_XbdhR8IqNzUHw== 02:33:15 INFO - x-amz-version-id: ..QJpBJvoMS2gJB8PzVp_yTknCVzZpgs 02:33:15 INFO - Expected file size: 16270960 02:33:15 INFO - Obtained file size: 16270960 02:33:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:33:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:33:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:33:22 INFO - Http code: 200 02:33:22 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 02:33:22 INFO - x-amz-cf-id: kplRTtfFk5DWNTJki-_IiW2tf_ZXvUJZkLIRWXZaqfYmh9c_0FLoFA== 02:33:22 INFO - x-amz-version-id: HzIUwkurC25uciVA5KuJUMLMrxs.c_3N 02:33:23 INFO - Expected file size: 14409038 02:33:23 INFO - Obtained file size: 14409038 02:33:23 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')]} 02:33:23 INFO - trying https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:33:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/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 02:33:26 INFO - Downloaded 109878872 bytes. 02:33:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:33:26 INFO - mkdir: /builds/slave/test/properties 02:33:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:33:26 INFO - Writing to file /builds/slave/test/properties/build_url 02:33:26 INFO - Contents: 02:33:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:33:27 INFO - Running post-action listener: _resource_record_post_action 02:33:27 INFO - Running post-action listener: set_extra_try_arguments 02:33:27 INFO - [mozharness: 2017-01-09 10:33:27.162316Z] Finished download-and-extract step (success) 02:33:27 INFO - [mozharness: 2017-01-09 10:33:27.162465Z] Running populate-webroot step. 02:33:27 INFO - Running pre-action listener: _resource_record_pre_action 02:33:27 INFO - Running main action method: populate_webroot 02:33:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:33:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:33:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:33:27 INFO - '--tppagecycles', 02:33:27 INFO - '7'], 02:33:27 INFO - 'tests': ['tsvgm']}}, 02:33:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:33:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:33:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:33:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:33:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:33:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:33:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:27 INFO - 'talos_options': ['--disable-e10s'], 02:33:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:27 INFO - 'talos_options': ['--disable-e10s'], 02:33:27 INFO - 'tests': ['damp', 'tps']}, 02:33:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:27 INFO - 'tests': ['damp', 'tps']}, 02:33:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:33:27 INFO - 'tests': ['dromaeo_dom']}, 02:33:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:33:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:33:27 INFO - 'tests': ['basic_compositor_video']}, 02:33:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:33:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:33:27 INFO - 'tests': ['a11yr', 02:33:27 INFO - 'ts_paint', 02:33:27 INFO - 'tpaint', 02:33:27 INFO - 'sessionrestore', 02:33:27 INFO - 'sessionrestore_no_auto_restore', 02:33:27 INFO - 'tabpaint']}, 02:33:27 INFO - 'other-e10s': {'tests': ['a11yr', 02:33:27 INFO - 'ts_paint', 02:33:27 INFO - 'tpaint', 02:33:27 INFO - 'sessionrestore', 02:33:27 INFO - 'sessionrestore_no_auto_restore', 02:33:27 INFO - 'tabpaint']}, 02:33:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:33:27 INFO - 'ts_paint', 02:33:27 INFO - 'tpaint', 02:33:27 INFO - 'sessionrestore', 02:33:27 INFO - 'sessionrestore_no_auto_restore', 02:33:27 INFO - 'tabpaint']}, 02:33:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:33:27 INFO - 'ts_paint', 02:33:27 INFO - 'tpaint', 02:33:27 INFO - 'sessionrestore', 02:33:27 INFO - 'sessionrestore_no_auto_restore', 02:33:27 INFO - 'tabpaint']}, 02:33:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:33:27 INFO - 'tests': ['a11yr', 02:33:27 INFO - 'ts_paint', 02:33:27 INFO - 'tpaint', 02:33:27 INFO - 'sessionrestore', 02:33:27 INFO - 'sessionrestore_no_auto_restore', 02:33:27 INFO - 'tabpaint']}, 02:33:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:33:27 INFO - 'tests': ['a11yr', 02:33:27 INFO - 'ts_paint', 02:33:27 INFO - 'tpaint', 02:33:27 INFO - 'sessionrestore', 02:33:27 INFO - 'sessionrestore_no_auto_restore', 02:33:27 INFO - 'tabpaint']}, 02:33:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:33:27 INFO - 'tests': ['tsvgx', 02:33:27 INFO - 'tsvgr_opacity', 02:33:27 INFO - 'tart', 02:33:27 INFO - 'tscrollx', 02:33:27 INFO - 'cart']}, 02:33:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:33:27 INFO - 'tsvgr_opacity', 02:33:27 INFO - 'tart', 02:33:27 INFO - 'tscrollx', 02:33:27 INFO - 'cart']}, 02:33:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:27 INFO - 'talos_options': ['--disable-e10s'], 02:33:27 INFO - 'tests': ['tp5o']}, 02:33:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:27 INFO - 'tests': ['tp5o']}, 02:33:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:27 INFO - 'talos_options': ['--disable-e10s', 02:33:27 INFO - '--xperf_path', 02:33:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:27 INFO - 'tests': ['tp5n']}, 02:33:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:27 INFO - 'talos_options': ['--xperf_path', 02:33:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:27 INFO - 'tests': ['tp5n']}}, 02:33:27 INFO - 'talos.zip': {'path': '', 02:33:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:33:27 INFO - Running post-action listener: _resource_record_post_action 02:33:27 INFO - [mozharness: 2017-01-09 10:33:27.181118Z] Finished populate-webroot step (success) 02:33:27 INFO - [mozharness: 2017-01-09 10:33:27.181248Z] Running create-virtualenv step. 02:33:27 INFO - Running pre-action listener: _resource_record_pre_action 02:33:27 INFO - Running main action method: create_virtualenv 02:33:27 INFO - Creating virtualenv /builds/slave/test/build/venv 02:33:27 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 02:33:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:33:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:33:27 INFO - Using real prefix '/tools/python27' 02:33:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:33:28 INFO - Installing distribute.............................................................................................................................................................................................done. 02:33:30 INFO - Installing pip.................done. 02:33:30 INFO - Return code: 0 02:33:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:33:31 INFO - Reading from file tmpfile_stdout 02:33:31 INFO - Output received: 02:33:31 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) 02:33:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cce1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbb51f470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caf5d30>, '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 0x10c95bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10caedb20>, '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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 02:33:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:33:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VH4Y4kKgyH/Render', 02:33:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:31 INFO - 'HOME': '/Users/cltbld', 02:33:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:31 INFO - 'LOGNAME': 'cltbld', 02:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:31 INFO - 'MOZ_NO_REMOTE': '1', 02:33:31 INFO - 'NO_EM_RESTART': '1', 02:33:31 INFO - 'PAGER': '/bin/cat', 02:33:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:31 INFO - 'PWD': '/builds/slave/test', 02:33:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:31 INFO - 'SHELL': '/bin/bash', 02:33:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5sCBz8jKS/Listeners', 02:33:31 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 02:33:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:31 INFO - 'USER': 'cltbld', 02:33:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:31 INFO - 'XPC_FLAGS': '0x0', 02:33:31 INFO - 'XPC_SERVICE_NAME': '0', 02:33:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:31 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 02:33:31 INFO - Cleaning up... 02:33:31 INFO - Return code: 0 02:33:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cce1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbb51f470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caf5d30>, '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 0x10c95bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10caedb20>, '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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 02:33:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:33:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VH4Y4kKgyH/Render', 02:33:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:31 INFO - 'HOME': '/Users/cltbld', 02:33:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:31 INFO - 'LOGNAME': 'cltbld', 02:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:31 INFO - 'MOZ_NO_REMOTE': '1', 02:33:31 INFO - 'NO_EM_RESTART': '1', 02:33:31 INFO - 'PAGER': '/bin/cat', 02:33:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:31 INFO - 'PWD': '/builds/slave/test', 02:33:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:31 INFO - 'SHELL': '/bin/bash', 02:33:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5sCBz8jKS/Listeners', 02:33:31 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 02:33:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:31 INFO - 'USER': 'cltbld', 02:33:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:31 INFO - 'XPC_FLAGS': '0x0', 02:33:31 INFO - 'XPC_SERVICE_NAME': '0', 02:33:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:31 INFO - Downloading/unpacking psutil>=3.1.1 02:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:33:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:35 INFO - Installing collected packages: psutil 02:33:35 INFO - Running setup.py install for psutil 02:33:35 INFO - building 'psutil._psutil_osx' extension 02:33:35 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 02:33:36 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 02:33:36 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 02:33:36 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 02:33:36 INFO - building 'psutil._psutil_posix' extension 02:33:36 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 02:33:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:33:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:33:36 INFO - ^ 02:33:36 INFO - 1 warning generated. 02:33:36 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 02:33:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:36 INFO - Successfully installed psutil 02:33:36 INFO - Cleaning up... 02:33:37 INFO - Return code: 0 02:33:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:33: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')]} 02:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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')]} 02:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cce1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbb51f470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caf5d30>, '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 0x10c95bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10caedb20>, '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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 02:33: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:33: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 mozsystemmonitor==0.3 02:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VH4Y4kKgyH/Render', 02:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:37 INFO - 'HOME': '/Users/cltbld', 02:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:37 INFO - 'LOGNAME': 'cltbld', 02:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:37 INFO - 'MOZ_NO_REMOTE': '1', 02:33:37 INFO - 'NO_EM_RESTART': '1', 02:33:37 INFO - 'PAGER': '/bin/cat', 02:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:37 INFO - 'PWD': '/builds/slave/test', 02:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:37 INFO - 'SHELL': '/bin/bash', 02:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5sCBz8jKS/Listeners', 02:33:37 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 02:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:37 INFO - 'USER': 'cltbld', 02:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:37 INFO - 'XPC_FLAGS': '0x0', 02:33:37 INFO - 'XPC_SERVICE_NAME': '0', 02:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:33:37 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 02:33:37 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 02:33:37 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 02:33:37 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 02:33:37 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 02:33:37 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 02:33:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:33:40 INFO - Installing collected packages: mozsystemmonitor 02:33:40 INFO - Running setup.py install for mozsystemmonitor 02:33:40 INFO - Successfully installed mozsystemmonitor 02:33:40 INFO - Cleaning up... 02:33:40 INFO - Return code: 0 02:33:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:33:40 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')]} 02:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:40 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')]} 02:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:40 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 0x10cce1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbb51f470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caf5d30>, '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 0x10c95bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10caedb20>, '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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 02:33:40 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 02:33:40 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 02:33:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VH4Y4kKgyH/Render', 02:33:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:40 INFO - 'HOME': '/Users/cltbld', 02:33:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:40 INFO - 'LOGNAME': 'cltbld', 02:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:40 INFO - 'MOZ_NO_REMOTE': '1', 02:33:40 INFO - 'NO_EM_RESTART': '1', 02:33:40 INFO - 'PAGER': '/bin/cat', 02:33:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:40 INFO - 'PWD': '/builds/slave/test', 02:33:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:40 INFO - 'SHELL': '/bin/bash', 02:33:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5sCBz8jKS/Listeners', 02:33:40 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 02:33:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:40 INFO - 'USER': 'cltbld', 02:33:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:40 INFO - 'XPC_FLAGS': '0x0', 02:33:40 INFO - 'XPC_SERVICE_NAME': '0', 02:33:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:40 INFO - Downloading/unpacking jsonschema==2.5.1 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:33:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:33:43 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 02:33:43 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 02:33:43 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 02:33:43 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 02:33:43 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 02:33:43 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 02:33:43 INFO - Downloading functools32-3.2.3-2.tar.gz 02:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:33:43 INFO - warning: no files found matching '*.txt' 02:33:43 INFO - no previously-included directories found matching 'build' 02:33:43 INFO - no previously-included directories found matching 'dist' 02:33:43 INFO - no previously-included directories found matching '.git*' 02:33:43 INFO - Installing collected packages: jsonschema, functools32 02:33:43 INFO - Running setup.py install for functools32 02:33:43 INFO - warning: no files found matching '*.txt' 02:33:43 INFO - no previously-included directories found matching 'build' 02:33:43 INFO - no previously-included directories found matching 'dist' 02:33:43 INFO - no previously-included directories found matching '.git*' 02:33:43 INFO - Successfully installed jsonschema functools32 02:33:43 INFO - Cleaning up... 02:33:44 INFO - Return code: 0 02:33:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:33:44 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')]} 02:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:44 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')]} 02:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:44 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 0x10cce1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbb51f470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caf5d30>, '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 0x10c95bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10caedb20>, '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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 02:33:44 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 02:33:44 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 02:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VH4Y4kKgyH/Render', 02:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:44 INFO - 'HOME': '/Users/cltbld', 02:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:44 INFO - 'LOGNAME': 'cltbld', 02:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:44 INFO - 'MOZ_NO_REMOTE': '1', 02:33:44 INFO - 'NO_EM_RESTART': '1', 02:33:44 INFO - 'PAGER': '/bin/cat', 02:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:44 INFO - 'PWD': '/builds/slave/test', 02:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:44 INFO - 'SHELL': '/bin/bash', 02:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5sCBz8jKS/Listeners', 02:33:44 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 02:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:44 INFO - 'USER': 'cltbld', 02:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:44 INFO - 'XPC_FLAGS': '0x0', 02:33:44 INFO - 'XPC_SERVICE_NAME': '0', 02:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:33:44 INFO - Cleaning up... 02:33:44 INFO - Return code: 0 02:33:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33:44 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')]} 02:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:44 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')]} 02:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:44 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 0x10cce1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbb51f470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caf5d30>, '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 0x10c95bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10caedb20>, '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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 02:33:44 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 02:33:44 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 02:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VH4Y4kKgyH/Render', 02:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:44 INFO - 'HOME': '/Users/cltbld', 02:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:44 INFO - 'LOGNAME': 'cltbld', 02:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:44 INFO - 'MOZ_NO_REMOTE': '1', 02:33:44 INFO - 'NO_EM_RESTART': '1', 02:33:44 INFO - 'PAGER': '/bin/cat', 02:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:44 INFO - 'PWD': '/builds/slave/test', 02:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:44 INFO - 'SHELL': '/bin/bash', 02:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5sCBz8jKS/Listeners', 02:33:44 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 02:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:44 INFO - 'USER': 'cltbld', 02:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:44 INFO - 'XPC_FLAGS': '0x0', 02:33:44 INFO - 'XPC_SERVICE_NAME': '0', 02:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:44 INFO - Downloading/unpacking blobuploader==1.2.4 02:33:44 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 02:33:44 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 02:33:44 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 02:33:44 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 02:33:44 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 02:33:44 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 02:33:47 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33:47 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 02:33:47 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 02:33:47 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 02:33:47 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 02:33:47 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 02:33:47 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 02:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33:47 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 02:33:47 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 02:33:47 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 02:33:47 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 02:33:47 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 02:33:47 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 02:33:48 INFO - Downloading docopt-0.6.1.tar.gz 02:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:48 INFO - Running setup.py install for blobuploader 02:33:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:48 INFO - Running setup.py install for requests 02:33:49 INFO - Running setup.py install for docopt 02:33:49 INFO - Successfully installed blobuploader requests docopt 02:33:49 INFO - Cleaning up... 02:33:49 INFO - Return code: 0 02:33:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:49 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')]} 02:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:49 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')]} 02:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:49 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 0x10cce1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbb51f470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caf5d30>, '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 0x10c95bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10caedb20>, '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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 02:33:49 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 02:33:49 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 02:33:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VH4Y4kKgyH/Render', 02:33:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:49 INFO - 'HOME': '/Users/cltbld', 02:33:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:49 INFO - 'LOGNAME': 'cltbld', 02:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:49 INFO - 'MOZ_NO_REMOTE': '1', 02:33:49 INFO - 'NO_EM_RESTART': '1', 02:33:49 INFO - 'PAGER': '/bin/cat', 02:33:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:49 INFO - 'PWD': '/builds/slave/test', 02:33:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:49 INFO - 'SHELL': '/bin/bash', 02:33:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5sCBz8jKS/Listeners', 02:33:49 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 02:33:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:49 INFO - 'USER': 'cltbld', 02:33:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:49 INFO - 'XPC_FLAGS': '0x0', 02:33:49 INFO - 'XPC_SERVICE_NAME': '0', 02:33:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:49 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-b783bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:49 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-xZ5w5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:49 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-fByyuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:49 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-a9e4HH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:50 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-NetqN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:50 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-dkdxeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:50 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-uCEXNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:50 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-WZocMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:50 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-cQRlCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:50 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-mq43Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:50 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-GvwFLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:50 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-KaZUsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:50 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-63YVQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:51 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-WE0IMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:51 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-7inGjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:51 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-I0OYQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:51 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-nFtXLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:33:51 INFO - Running setup.py install for manifestparser 02:33:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:33:51 INFO - Running setup.py install for mozcrash 02:33:51 INFO - Running setup.py install for mozdebug 02:33:51 INFO - Running setup.py install for mozdevice 02:33:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:33:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:52 INFO - Running setup.py install for mozfile 02:33:52 INFO - Running setup.py install for mozhttpd 02:33:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:52 INFO - Running setup.py install for mozinfo 02:33:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:52 INFO - Running setup.py install for mozInstall 02:33:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:52 INFO - Running setup.py install for mozleak 02:33:52 INFO - Running setup.py install for mozlog 02:33:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:52 INFO - Running setup.py install for moznetwork 02:33:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:53 INFO - Running setup.py install for mozprocess 02:33:53 INFO - Running setup.py install for mozprofile 02:33:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:53 INFO - Running setup.py install for mozrunner 02:33:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:53 INFO - Running setup.py install for mozscreenshot 02:33:53 INFO - Running setup.py install for moztest 02:33:53 INFO - Running setup.py install for mozversion 02:33:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:54 INFO - Cleaning up... 02:33:54 INFO - Return code: 0 02:33:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:54 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')]} 02:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:54 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')]} 02:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:54 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 0x10cce1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbb51f470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caf5d30>, '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 0x10c95bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10caedb20>, '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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 02:33:54 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 02:33:54 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 02:33:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VH4Y4kKgyH/Render', 02:33:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:54 INFO - 'HOME': '/Users/cltbld', 02:33:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:54 INFO - 'LOGNAME': 'cltbld', 02:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:54 INFO - 'MOZ_NO_REMOTE': '1', 02:33:54 INFO - 'NO_EM_RESTART': '1', 02:33:54 INFO - 'PAGER': '/bin/cat', 02:33:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:54 INFO - 'PWD': '/builds/slave/test', 02:33:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:54 INFO - 'SHELL': '/bin/bash', 02:33:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5sCBz8jKS/Listeners', 02:33:54 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 02:33:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:54 INFO - 'USER': 'cltbld', 02:33:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:54 INFO - 'XPC_FLAGS': '0x0', 02:33:54 INFO - 'XPC_SERVICE_NAME': '0', 02:33:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:54 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-6A6yGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:54 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)) 02:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:54 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-E7VXJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:54 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)) 02:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:54 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-_AhivK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:54 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)) 02:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:54 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-0hTIUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:54 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)) 02:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:54 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-8wCRVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:54 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)) 02:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:54 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-X2u7QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:54 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)) 02:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:54 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-hwP7sF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:55 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)) 02:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:55 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-H7z14v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:55 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)) 02:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:55 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-Nc18FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:55 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)) 02:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:55 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-p_gfgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:55 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)) 02:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:55 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-IfV9JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:55 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)) 02:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:55 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-J2ePWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:55 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)) 02:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:55 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-aXHaPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:55 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)) 02:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:55 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-l5Wj7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:55 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)) 02:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:55 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-7QQ5IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:55 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)) 02:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:55 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-BWwkF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:56 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)) 02:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:56 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-xtx5GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:56 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)) 02:33:56 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)) 02:33:56 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)) 02:33:56 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)) 02:33:56 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)) 02:33:56 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)) 02:33:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:56 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 02:33:56 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 02:33:56 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 02:33:56 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 02:33:56 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 02:33:56 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 02:33:58 INFO - Downloading blessings-1.6.tar.gz 02:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:58 INFO - Installing collected packages: blessings 02:33:58 INFO - Running setup.py install for blessings 02:33:59 INFO - Successfully installed blessings 02:33:59 INFO - Cleaning up... 02:33:59 INFO - Return code: 0 02:33:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:59 INFO - Reading from file tmpfile_stdout 02:33:59 INFO - Current package versions: 02:33:59 INFO - blessings == 1.6 02:33:59 INFO - blobuploader == 1.2.4 02:33:59 INFO - docopt == 0.6.1 02:33:59 INFO - functools32 == 3.2.3-2 02:33:59 INFO - jsonschema == 2.5.1 02:33:59 INFO - manifestparser == 1.1 02:33:59 INFO - mozInstall == 1.12 02:33:59 INFO - mozcrash == 1.0 02:33:59 INFO - mozdebug == 0.1 02:33:59 INFO - mozdevice == 0.48 02:33:59 INFO - mozfile == 1.2 02:33:59 INFO - mozhttpd == 0.7 02:33:59 INFO - mozinfo == 0.9 02:33:59 INFO - mozleak == 0.1 02:33:59 INFO - mozlog == 3.4 02:33:59 INFO - moznetwork == 0.27 02:33:59 INFO - mozprocess == 0.23 02:33:59 INFO - mozprofile == 0.28 02:33:59 INFO - mozrunner == 6.13 02:33:59 INFO - mozscreenshot == 0.1 02:33:59 INFO - mozsystemmonitor == 0.3 02:33:59 INFO - moztest == 0.8 02:33:59 INFO - mozversion == 1.4 02:33:59 INFO - psutil == 3.1.1 02:33:59 INFO - requests == 1.2.3 02:33:59 INFO - wsgiref == 0.1.2 02:33:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:59 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')]} 02:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:59 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')]} 02:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:59 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 0x10cce1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbb51f470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caf5d30>, '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 0x10c95bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10caedb20>, '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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 02:33:59 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 02:33:59 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 02:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VH4Y4kKgyH/Render', 02:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:59 INFO - 'HOME': '/Users/cltbld', 02:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:59 INFO - 'LOGNAME': 'cltbld', 02:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:59 INFO - 'MOZ_NO_REMOTE': '1', 02:33:59 INFO - 'NO_EM_RESTART': '1', 02:33:59 INFO - 'PAGER': '/bin/cat', 02:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:59 INFO - 'PWD': '/builds/slave/test', 02:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:59 INFO - 'SHELL': '/bin/bash', 02:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5sCBz8jKS/Listeners', 02:33:59 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 02:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:59 INFO - 'USER': 'cltbld', 02:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:59 INFO - 'XPC_FLAGS': '0x0', 02:33:59 INFO - 'XPC_SERVICE_NAME': '0', 02:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:59 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)) 02:33:59 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)) 02:33:59 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)) 02:33:59 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)) 02:33:59 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)) 02:33:59 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)) 02:33:59 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)) 02:33:59 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)) 02:33:59 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)) 02:33:59 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)) 02:33:59 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)) 02:33:59 INFO - Cleaning up... 02:33:59 INFO - Return code: 0 02:33:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:33:59 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')]} 02:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:59 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')]} 02:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:59 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 0x10cce1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc57570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbb51f470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10caf5d30>, '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 0x10c95bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10caedb20>, '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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 02:33:59 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 02:33:59 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 02:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VH4Y4kKgyH/Render', 02:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:59 INFO - 'HOME': '/Users/cltbld', 02:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:59 INFO - 'LOGNAME': 'cltbld', 02:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:59 INFO - 'MOZ_NO_REMOTE': '1', 02:33:59 INFO - 'NO_EM_RESTART': '1', 02:33:59 INFO - 'PAGER': '/bin/cat', 02:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:59 INFO - 'PWD': '/builds/slave/test', 02:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:59 INFO - 'SHELL': '/bin/bash', 02:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5sCBz8jKS/Listeners', 02:33:59 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 02:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:59 INFO - 'USER': 'cltbld', 02:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:59 INFO - 'XPC_FLAGS': '0x0', 02:33:59 INFO - 'XPC_SERVICE_NAME': '0', 02:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:33:59 INFO - Cleaning up... 02:33:59 INFO - Return code: 0 02:33:59 INFO - Running post-action listener: _resource_record_post_action 02:33:59 INFO - Running post-action listener: _start_resource_monitoring 02:34:00 INFO - Starting resource monitoring. 02:34:00 INFO - [mozharness: 2017-01-09 10:34:00.021936Z] Finished create-virtualenv step (success) 02:34:00 INFO - [mozharness: 2017-01-09 10:34:00.022984Z] Running install step. 02:34:00 INFO - Running pre-action listener: _resource_record_pre_action 02:34:00 INFO - Running main action method: install 02:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:00 INFO - Reading from file tmpfile_stdout 02:34:00 INFO - Detecting whether we're running mozinstall >=1.0... 02:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:34:00 INFO - Reading from file tmpfile_stdout 02:34:00 INFO - Output received: 02:34:00 INFO - Usage: mozinstall [options] installer 02:34:00 INFO - Options: 02:34:00 INFO - -h, --help show this help message and exit 02:34:00 INFO - -d DEST, --destination=DEST 02:34:00 INFO - Directory to install application into. [default: 02:34:00 INFO - "/builds/slave/test"] 02:34:00 INFO - --app=APP Application being installed. [default: firefox] 02:34:00 INFO - mkdir: /builds/slave/test/build/application 02:34:00 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'] 02:34:00 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 02:34:30 INFO - Reading from file tmpfile_stdout 02:34:30 INFO - Output received: 02:34:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:34:30 INFO - Running post-action listener: _resource_record_post_action 02:34:30 INFO - [mozharness: 2017-01-09 10:34:30.953141Z] Finished install step (success) 02:34:30 INFO - [mozharness: 2017-01-09 10:34:30.953285Z] Running run-tests step. 02:34:30 INFO - Running pre-action listener: _resource_record_pre_action 02:34:30 INFO - Running main action method: run_tests 02:34:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:34:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:34:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:34:30 INFO - 2017-01-09 02:34:30.968 screenresolution[1632:8769] starting screenresolution argv=screenresolution get 02:34:30 INFO - 2017-01-09 02:34:30.973 screenresolution[1632:8769] Display 0: 1600x1200x32@60 02:34:30 INFO - 2017-01-09 02:34:30.979 screenresolution[1633:8773] starting screenresolution argv=screenresolution list 02:34:30 INFO - Available Modes on Display 0 02:34:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:34:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:34:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:34:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:34:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:34:31 INFO - Intel Iris: 02:34:31 INFO - Chipset Model: Intel Iris 02:34:31 INFO - Type: GPU 02:34:31 INFO - Bus: Built-In 02:34:31 INFO - VRAM (Dynamic, Max): 1536 MB 02:34:31 INFO - Vendor: Intel (0x8086) 02:34:31 INFO - Device ID: 0x0a2e 02:34:31 INFO - Revision ID: 0x0009 02:34:31 INFO - Displays: 02:34:31 INFO - Display: 02:34:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:34:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:34:31 INFO - Display Serial Number: 1600x1200 60 02:34:31 INFO - Main Display: Yes 02:34:31 INFO - Mirror: Off 02:34:31 INFO - Online: Yes 02:34:31 INFO - Rotation: Supported 02:34:31 INFO - Return code: 0 02:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:34:31 INFO - Python 2.7.3 02:34:31 INFO - Return code: 0 02:34:31 INFO - grabbing minidump binary from tooltool 02:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:31 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 0x10caf5d30>, '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 0x10c95bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10caedb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:34:31 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 02:34:31 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 02:34:31 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 02:34:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:34:31 INFO - Return code: 0 02:34:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:34:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:34:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:34:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:34:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:34:31 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/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0068', '--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 02:34:31 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/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0068 --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 02:34:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VH4Y4kKgyH/Render', 02:34:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:31 INFO - 'HOME': '/Users/cltbld', 02:34:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:31 INFO - 'LOGNAME': 'cltbld', 02:34:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:34:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:31 INFO - 'MOZ_NO_REMOTE': '1', 02:34:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:34:31 INFO - 'NO_EM_RESTART': '1', 02:34:31 INFO - 'PAGER': '/bin/cat', 02:34:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:31 INFO - 'PWD': '/builds/slave/test', 02:34:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:34:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:31 INFO - 'SHELL': '/bin/bash', 02:34:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W5sCBz8jKS/Listeners', 02:34:31 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 02:34:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:31 INFO - 'USER': 'cltbld', 02:34:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:31 INFO - 'XPC_FLAGS': '0x0', 02:34:31 INFO - 'XPC_SERVICE_NAME': '0', 02:34:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:31 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/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0068', '--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 02:34:31 INFO - mozversion application_buildid: 20170108234108 02:34:31 INFO - mozversion application_changeset: fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 02:34:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:34:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:34:31 INFO - mozversion application_name: Firefox 02:34:31 INFO - mozversion application_remotingname: firefox-dev 02:34:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:34:31 INFO - mozversion application_vendor: Mozilla 02:34:31 INFO - mozversion application_version: 52.0a2 02:34:31 INFO - mozversion platform_buildid: 20170108234108 02:34:31 INFO - mozversion platform_changeset: fed81ec38bdf9a6ae80bdbedf5845d0fe84c1c86 02:34:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:34:31 INFO - mozversion platform_version: 52.0a2 02:34:31 INFO - using testdate: 1483958071 02:34:31 INFO - actual date: 1483958071 02:34:31 INFO - starting webserver on 'localhost:49253' 02:34:31 INFO - SUITE-START | Running 2 tests 02:34:31 INFO - TEST-START | dromaeo_css 02:34:31 INFO - operating with platform_type : mac_ 02:34:31 INFO - Initialising browser for dromaeo_css test... 02:34:31 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpstwdvG/profile http://localhost:49253/getInfo.html) 02:34:34 INFO - PROCESS | 1643 | 2017-01-09 02:34:34.709 plugin-container[1645:8947] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 02:34:34 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:34:34 INFO - PROCESS | 1643 | 2017-01-09 02:34:34.712 plugin-container[1645:8947] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 02:34:34 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:34:34 INFO - PROCESS | 1643 | 2017-01-09 02:34:34.712 plugin-container[1645:8947] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:34:34 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 02:34:34 INFO - PROCESS | 1643 | colorDepth:24 02:34:34 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 02:34:34 INFO - PROCESS | 1643 | __metrics 02:34:34 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 02:34:35 INFO - TEST-INFO | 1643: exit 0 02:34:35 INFO - Browser initialized. 02:34:35 INFO - Running cycle 1/1 for dromaeo_css test... 02:34:35 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpstwdvG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:38 INFO - PROCESS | 1647 | 2017-01-09 02:34:38.482 plugin-container[1648:9083] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 02:34:38 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:34:38 INFO - PROCESS | 1647 | 2017-01-09 02:34:38.484 plugin-container[1648:9083] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x891b, name = 'com.apple.CFPasteboardClient' 02:34:38 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:34:38 INFO - PROCESS | 1647 | 2017-01-09 02:34:38.484 plugin-container[1648:9083] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:34:48 INFO - PROCESS | 1647 | RSS: Main: 229224448 02:34:48 INFO - PROCESS | 1647 | 02:37:51 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49253/tests/dromaeo/cssquery-ext.html) 02:37:53 INFO - PROCESS | 1647 | RSS: Main: 233521152 02:37:53 INFO - PROCESS | 1647 | 02:40:55 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-ext.html (next: http://localhost:49253/tests/dromaeo/cssquery-jquery.html) 02:40:56 INFO - PROCESS | 1647 | RSS: Main: 243138560 02:40:56 INFO - PROCESS | 1647 | 02:43:58 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49253/tests/dromaeo/cssquery-mootools.html) 02:43:59 INFO - PROCESS | 1647 | RSS: Main: 246087680 02:43:59 INFO - PROCESS | 1647 | 02:47:00 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49253/tests/dromaeo/cssquery-prototype.html) 02:47:01 INFO - PROCESS | 1647 | RSS: Main: 245710848 02:47:01 INFO - PROCESS | 1647 | 02:50:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49253/tests/dromaeo/cssquery-yui.html) 02:50:05 INFO - PROCESS | 1647 | RSS: Main: 248815616 02:50:05 INFO - PROCESS | 1647 | 02:53:07 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-yui.html (next: http://localhost:49253/tests/dromaeo/cssquery-dojo.html) 02:53:07 INFO - PROCESS | 1647 | RSS: Main: 250441728 02:53:07 INFO - PROCESS | 1647 | 02:53:07 INFO - PROCESS | 1647 | __start_tp_report 02:53:07 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 02:53:07 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 02:53:07 INFO - PROCESS | 1647 | |i|pagename|runs| 02:53:07 INFO - PROCESS | 1647 | |0;dojo.html;3370.730341572674;3396.5075064115704;3422.418188907885;3440.8967730968066;3489.5638045244345;5728.598998070137;5792.420757924206;5846.152307915349;5913.2017177681;5919.200907877435;5883.823485295437;5909.379515150912;5910;5950.79172228972;5971.044632858743;5253.816116435925;5284.075286824809;5343.625946183769;5362.490563396491;5365.141577347626;5358.3569971603465;5367.919481207785;5379.139337705968;5385.407605163448;5460.399356070849;5241.109011468059;5246.1606143017125;5365.812196573121;5369.7583608737705;5384.838454846361;5269.762860671279;5294.841154765363;5301.5758739301145;5312.521873031426;5343.812966546152;5031.245313203012;5169.767360468751;5196.402413722395;5226.1638137898135;5365.973170134124;5730.856728581777;5738.254026976508;5750.683712395817;5758.222639943596;5793.855153621151;5123.846284611468;5125.513076257749;6137.202163718733;6142.8364392337535;6210.1616281801835;5124.871878203037;5291.312129423189;6279;6289.622622642656;6300.180976473029;6000.069989151689;6000.939990600038;6004.969975150097;6005.969970150165;6012.068129439944;6141.854248382324;6227;6274.247090349188;6337.841553961096;6365.713542890581;6186.381361863868;6220.688965551704;6225.470834978987;6245.500359971192;6317.957537006434;5609.775608975595;5891.792182602642;6227.844303892439;6263.749450021948;6267.5299352548745;5045.646804723708;6200;6210.472109870621;6232.719527621268;6252.6873656317;4986.675866068694;6128.533679014772;6128.6016408934165;6161.476274516626;6184.474319682788;4902.313676085351;4905.754712264373;4909.484504127086;4911.386076740408;4921.458639549646;4409.603135717736;4426.675995102532;4432.667549933768;4437.622802061796;4441.733495990251;5727.825795711869;5850.970745146247;5859.707014649251;5956.404359564009;5980.0431930890845;6215.160953271251;6233.688315584202;6252.406021427957;6278.4035516625845;6283.622982621057;5716.456936591017;5832.795852145239;5978.406885914739;6013.067974463877;6102.298235702951;5385.246065550826;5430.049741295336;5431.5926305526455;5432.565394768488;5526.226328314039;6415.486761059104;6431;6448.193975753031;6457.192850893733;6465.450436712838;5175.327207463006;6221.595596286227;6274.592151510137;6286;6300.84247893788;6298.401651843067;6313.494920406449;6388.968055159695;6437.839054023687;6458.580192287486;6247.219097612799;6257.56197066201;6258.217722784652;6260.342664020212;6260.373962603885;6176.104464852661;6247.781327653511;6249.625022498664;6264.968675156595;6269.62382257066;6057.697115144313;6152.354002829638;6162.414570615784;6171.290301615192;6202.41077097675;5982.7307771149535;6233.2208473940755;6235.345288744798;6236.594621349598;6254.468370188403;5338.065838478328;5893.616914900518;6026.608270462406;6058.121572371893;6151.569390142826;6071.332153463204;6101.877962440815;6130.673316708229;6144.53915956314;6160.599561028519;6021.277446706424;6055.757769689163;6093.634381937098;6134.631922084689;6143.477804386677 02:53:07 INFO - PROCESS | 1647 | |1;ext.html;485.2091091520821;487.8292597590844;524.685188886668;525.2174260352076;529.2352550564436;37960.05099872505;39646;39686.99999999996;39768.80115599418;39984.80007599965;40823;40842.59157408433;41310.76067717973;41371.37942930851;41418.58581414192;9272.768180795483;9444.244460443182;9467.668631597895;9488.573014214342;9543.522823858813;7786.754119340907;8167.509949403055;8665.566721663892;8979.65305204218;9387.62449502019;9467.431954082742;9478.478683672396;9498.857517137249;9498.905010949906;9521.476318802463;7998.960005199937;9399.201067909236;9468.100530449665;9477.668281610111;9500.857487137699;9272.350935434522;9301.302402319852;9322.30082743797;9331.580078896466;9354.953225233898;39074.80462597697;39509.60490395088;39510;39518.604813952064;39590;3452.982735086334;3557.928841423183;3561.661642143992;3758.699304055669;3995.5205375355144;29361.09152905076;29633;29869.40261194764;30397.392052159055;30416.39167216643;3075.261937135094;3174.6984036516724;3187.3943950649536;3189.2505261263586;3194.520821876714;530155;536955;540862;543459.999999996;545494;61872;61996.38003619906;62197.37802621916;62369.37630623727;62647.12058638248;52921.7353913228;64012.03981940181;65411;65671;65699.34300656932;15954.441594544136;16075.598110047342;16239.837601623833;16264.83735162657;16265.674686506203;12314.076444266715;12383;12399.690007749878;12431.37843107859;12472.750544989049;15757.896947213585;17428.51238116703;18260.904345739298;18626.78925869814;18853.86876787397;3170.793898396597;6272.905906411407;7626.199249078878;7672.698190542815;7789.3768498519985;817.38287592867;1000.0449570660003;1003.9698809035741;1024.6721049264313;1054.3989925742253;28585.71364288612;29525.557116643267;29749.553756693665;30277.545836812464;30464.390712185632;867.4144952157269;1008.838585826279;1018.7860549284733;1046.1264843855313;1124.4265424633331;14947.70104597902;15344.079355238498;15489.5353139406;15612.4535641252;15711.921440392725;656452;662081;664248;665201;668587;56953.430465694815;57091.858162836514;57176.42823571711;57410.42589574134;57525;1318.2222488731695;1347.4677502386503;1362.5503583817317;1364.8908087352988;1372.0944176843434;25252.74747252504;28988.42023159567;29503.26241843885;29914.606831453868;30003.849980749957;55162.448375515734;55854.16218756803;55879;55885.99999999837;56076.71961640166;633144;634138;641588;642601;643333;25215.495690086464;25963.74036259613;26020.95916163408;42283;42594;44196;44703.329450058925;44749.10501790011;44802.77598611986;45044.77477612591;32026.83986580052;32103.23432211251;32994;36429;37356.252874941805;36766.264674705824;36776.63223367732;37067.62932370749;37790.62209377981;37798.81100594479;35305.82347088248;35850.4622430669;36489.27021459503;36534.63465365312;36802;31818.522722158723;33347.83282585195;33833;33914.49128263029;34103.4884476738;24871;24877.751222487543;25307;25478.617820733074;25516.617250741627 02:53:07 INFO - PROCESS | 1647 | |2;jquery.html;323.7733586489457;378.32280218409034;389.58509187715083;391.594699486032;411.9588041195881;14617.196054217015;14935.626609334771;15772.369105235777;16660.250288737006;17737.645247095068;16226.594335141597;18522.351717689882;19071;20027.499312517193;20153.798462015377;5218.608604354679;5486.177073438977;5491.643043202199;5497.45025497451;5512.39363669998;5236.581073514109;5404.351477822647;5422.186671999192;5465.426130256325;5480.232767412565;4452.1986042512335;5043.86513034568;5421.078416669156;5446.700431476267;5460.890782184354;5263.973680131594;5418.051840927861;5437.157240627689;5483.835484935458;5488.506034456918;5298.046351656701;5303;5344.412114667383;5365.302510673588;5374.167004114369;13242.073054886161;13375.063745537816;13537;13705.383257753325;13708.24604646744;2296.5636529059593;2301.4706617478073;2584.508943300767;2993.7006299370105;3006.0981705488266;10167.135793457564;10550.15598752098;12115.15193936416;12712.936435317857;14723.190224537646;1845.833874951261;1849.1863580024747;1851.6852135136924;1852.2590963614527;1876.6997280435064;124013;127928.36035819854;131079;133081.66918330887;133392.33303833517;11573.594924177612;11747.943786024125;11771.764564708657;11793.764124717458;11853.46659400329;14889.776653350209;14907.70184596302;14912.701745965236;14915.552533424014;14919.179445130405;7600.467967242351;8051.838963220703;8363.163683631588;8481;8618.181272779077;8300.543470109082;8320.916790832136;8327.250547450758;8435.662573497115;8441.36689748259;4431.911361772746;4573.268277075652;4573.451185857652;4631.8378856739855;4676.0647870426055;1578.5027716269337;1795.4613615915173;1975.8221760041665;1977.1893523655233;2034.4303594993426;710.0059916117477;787.3740376400775;845.602566793606;874.3355050161923;961.8124465729115;16117.677646447006;20564;20637.380878573666;20741;20797.480062998548;910.0626354854511;922.9861552076724;938.2212763406357;962.629387685746;1021.4637315409321;7080.716771329089;10963.945180274048;10976.780464390828;10981.780364392667;11006.064484518905;623106;627636;628404;633258;637730;118697;120852.0302204778;130961;132107;138727.30636346753;893.2318206342541;986.0435377683779;1013.6300250408696;1023.4575674892319;1036.3212096077082;18235;18259.269629214683;18475.445736627924;18475.722864156778;18617.069146542348;52431;52815.94368112693;53096;54118.458815411344;54517;72420;72644.63677681578;73791;74508.25491745013;74517.2548274532;8020.358371330163;8064;8088.433809633269;8247.21651443112;8343;8087.555184464911;11076.501557430096;12334;12509.499620015462;12602.046682764187;10592.629257975934;10775.760787509224;10799;11039.337639741641;11374.146938979444;9490.383125096847;10605.946970265099;10730.409827459252;10882.564697412332;10928.235023548275;9268.675596354095;10869.728256793644;11007.504662290055;11427.142964277878;11456.599019034295;7061.329173728487;7129.287071292829;7386.372158366599;7418.443616728659;8434.072252052392;8498.617562209593;9961.501924903581;10450.216233782648;10466.529006194893;11338.886611134112 02:53:07 INFO - PROCESS | 1647 | |3;mootools.html;1458.5041086030747;1489.195834249505;1669.223810927919;1728.7666165067728;1779.3327502186671;7565.621718914046;7820.608969551528;8098.514089154655;8542.871856922144;8543.188397102273;7015.193252775933;8030.23712747288;8057.388522295535;8335.249827515523;8405.117462666423;2295.242569951916;2312.90748370065;2327.615943369342;2328.3480625424822;2331.778481044298;1773.538879891231;2316.4903721181313;2353.752855950118;2355.352278123521;2372.881355932205;2052.5073982244303;2205.305328821416;2259.1076524772707;2284;2288.931332060041;2277.1119263487253;2287.4395773035544;2309.1340747219792;2319.9188028418926;2322.93031209064;2272.2728726807427;2299.379167624732;2299.482616411294;2302.82728795341;2309.457277539777;8193.590320484012;8226.876596850992;8278.710245141452;8287.12985136564;8299.917000829975;4998.375203099613;5146.9485305146845;5150.871228219325;5151.227315902607;5173.3016042834115;3132.903483780681;3222.1622378181605;3545.503629491873;3550.431930891071;3567.4292113261754;919.3105171121658;1012.8835183953793;1076.160594736107;1089.2810744908402;1096.2435919215716;10516.894831051668;10828.458577071193;10849.077828384598;10868.891311086945;11075.833862491989;4342.08816148606;4404.801783919731;4501.234790085693;4539.500654927955;4544.272916333371;8619.224269815746;8702.173293537104;8706.259967902672;8713.825723485621;8725.694600689072;4339.392485052095;5082.669626474268;5120.462351453044;5126.051680439131;5128.820491282861;4245.915081698348;4344.847930322424;4629.837955671535;4774.3077253798;4853.490383509751;3422.144463884029;3502.581454510927;3619.149499867529;3670.2292518570866;3751.981240093782;1111.127764704719;1113.3375641493299;1114.5207560748793;1121.0247085036071;1126.5550107707409;745.7911784700184;847.3009766942174;882.9779255518534;896.2202883491404;922.31748506105;5464.907018596296;5516.806911758069;5519.31008623922;5713.6857472838565;5739.540836733051;851.6465666748354;866.8179682266795;902.5261737587688;906.3247880329197;945.3099237556622;3595.352836489457;3774.8867533974026;3781.2248489059675;3893.980530097388;3895.220955808793;9852.655157069468;10044.849327260097;10236.948815256024;10254.128399086012;10271.281010329354;8358.414910956175;10189.898101018895;10195;10200.489975501196;10204.795904082026;7546.019017527687;7779.572123533147;7818.68725250995;7955.0851652060755;7964.800879978047;4783.282507623884;5346.663334166458;5434.64674796137;5463.836084917459;5656.490915817596;9274.072592740671;9325.673601423918;9334.439933603733;9422;9468.668596599086;8049;9494;9494.810103798023;9578.425294482353;9700.951495242478;6278.246610406781;6469.061986012096;6564.737410503526;6622.403983641495;6711.664416779239;7818.374530037697;7986.881836542772;8021.799455013438;8027.357811375193;8035.758927232192;6186.628802271878;6336.859365314288;6350.68246587678;7182.245864184186;7190.784276471505;6056.818295451144;6987.475939304471;7056.647167641495;7071.7878463646175;7100;6569.37590928861;6586.604803711793;6624.271330153776;6638.83402914931;6677.465802735866;4703.223968045234;4707.835225767081;4801.423829140525;4843.467218606021;4862.149123903232;4343.630791382768;4514.796834142406;4821.807127714852;4849.296851956376;4854.1747902857305 02:53:07 INFO - PROCESS | 1647 | |4;prototype.html;305.1699377692677;306.11837906828333;309.7939869986459;314.5250671486056;318.6876860676537;4174.979125104378;4712;5318.414974352818;5395.163749618815;5419.26839876617;4933.062718083562;5063.189889617662;5163.690178589287;5241.266222728821;5343.599230057742;3551.5205447264675;3584.372734771405;4046.502793966237;4075.49056367954;4154.940490175001;3863.285292220934;3994.406644826884;4063.6545893599077;4065.26825171469;4080.4092398689113;3453.4129198036267;3493.637481382263;4027.8791636250958;4045.858394956177;4074.370251899249;3942.014496375906;4057.5130984282073;4059.7564146151326;4073.452088206492;4087.5299340575916;3282.7045565899184;3536.664016918389;3557.5019497270405;3564.625714299987;3581.94627080594;4788;5135.948640513584;5140.357455318085;5142.948570514284;5178;4034.910574144994;4572.268437050089;4580.656450766206;4593.586577208034;4609.723416595015;5605.663660180402;5610.69141197234;5613.989481893258;5621.381648018714;5638.351589567212;3557.8576856925692;3773.5094637618263;3832.677726184462;3853.6531712146043;3870.8838734838;4921.975390123026;5584.274044374246;5836;5852.122181672783;5857.47282744555;3855.1904100139286;3858.401947698111;3864.246471937945;3868.903277418031;3873.9418908716393;3499.9475007874903;3678.5401824771902;3723.6834869035893;3940.369540873504;3948.052467407859;4132.710710250314;4195.517515485697;4479.328100784908;4562.384078149474;4607.3319368691355;4737.147313483537;5654.802081927113;5679.375268720438;5685.630434021776;5696.8860622787315;1096.7587130831205;1214.7509760499076;1220.7680540697238;1232.3653318540958;1270.7585558743808;781.9100803407681;854.8416895107165;863.7797361672733;868.4398562927003;878.9077146899483;4197.047483968946;4538.341940418621;4615.515370886009;4776.116418462596;4985.376827896513;4902.877428064256;4983.626228032912;5291.365036195682;5459.262999495097;5488.862778430571;4946.233333833262;5335.2393710075585;5352.759125839347;5378.435264297193;5419.945800542023;2439.8902049407466;2546.9235922922344;2786.70739572346;2868.0965495868736;2886.466003789306;4726.763661816895;4950.356453661073;5257.526822585985;5455.372632147274;5679.983605819957;4834.0331933612715;4865.829695960624;5035.79856805731;5226.661870647354;5257.868553286198;5213.921791173136;5214.567617525225;5580.972095139579;5652.943470565242;5713.914421236219;4443.466783985813;4763.595094417014;4824.986752781955;5438.450041738086;5545.390007099297;4665.090307390162;5222.503862133091;5266.368035835724;5416.620836541404;5432.56539476833;5043.519971219846;5653.604247702621;5658.575606829587;5667.263255776723;5675.744591493475;3183.5543023977125;3189.4737368333963;3269.2807582331848;3468.7745296555645;3692.2800053989213;5413.323334583177;5443.646162999393;5461.945380546303;5467.781288748405;5498.477644623755;4760.452547956891;5270.4202537721585;5293.411976406986;5295.523402893758;5299.092326762286;4729.314249433744;4871.537203965618;4930.91519865629;5113.590912727047;5291.708956007456;4256.510501292391;5069.9746501267255;5289.9471005291;5439.564834813126;5507.228987941611;4744.82096995021;5571.749271282721;5582;5599.468050535193;5626.409227031103;5257.710825904612;5418.133098704188;5439.809606663748;5445.945540544702;5451 02:53:07 INFO - PROCESS | 1647 | |5;yui.html;662.6090606542139;669.1568623534347;724.3842733676375;727.8689835829549;781.4100354232554;13949.302534873254;14652.633684157874;14666.779998300033;14684.412623495075;14778.630534236636;11355.602553910594;13305.733885322312;13474.326283685825;15018.774718379233;15072.6985460291;808.462372522272;826.8346330733847;834.4659417972503;834.5034704350901;835.7492752174354;677.8542613338132;689.8516818883938;818.9467684600512;820.3683163963744;823.2467292427451;824.6989848705209;870.7735988642967;871.1027641529236;873.2097451806094;874.396666300254;845.7674139611595;855.1234984141242;864.0409145848104;864.7665130414815;869.4305230074311;618.5670030978288;640.9679516024227;643.4177069751883;652.5236577298551;656.186328952096;12679.746405071939;13410.128341657859;13982;13996.860031399658;14011.29943502831;13406.664833379145;13583.864161358359;13822;13827.377768000464;13875.306234688225;11282.097432205404;11336.603218887381;11434.428278586038;11491.540338386454;11508.942455287754;3625.220577575834;3679.19057807282;3688.5204923359793;3699.815009249554;3720.534933133358;90321.54839225762;91305.54347228288;91941;92335.07664923399;92658.5367073167;8940.3741738079;10363.430011349448;10416.531256093494;10835.241533092765;10897.128229741602;21118.049687764087;21118.577628447652;21127.366179014654;21170.153193872382;21185.364439066852;6494.870102597922;6529.575577587441;7415.3326200642205;7452.403807695479;7735.419843511759;4179.185058913483;4181.623653871166;4207.453031105937;4279.957200427956;4383.473983122046;3335.93328133436;3448.8448019839166;3480.912977175591;3577.177249232691;3752.1745216052423;609.841301527102;627.6485168305763;667.9298673639295;687.7317846040048;690.4062506244626;569.1945896556409;587.8824235152987;649.7530938243438;669.363406471183;710.1052673631159;8936;9060.411073280216;9201.585928633227;9269.026752190923;9299.72100836976;579.6493121661418;586.3432955090326;621.7077973352608;634.0647544871277;637.2448648351718;3605.8737944171826;4267.722598031118;4300.397944287803;4315.438992930899;4417.558244175557;51247.437628118445;68589.65705171542;68937.65531172413;69741.55904543317;103119.48440257751;94427;94455.52772236094;96897;99295;100515;83122;83791.5810420944;85105.57447212849;85600.71598926146;87878;8434.493930364199;8537.50593646097;8561.315094792277;8650.78373040679;8653.567321634018;45330.866728332054;56182.71908640431;57002;57472.425275746704;57476.82386134663;44649;78519;79299;80832.59583702043;82787.5860620693;11330.60342887995;11336;11411.144164187554;11514.078873689918;11522.53909843597;11924.403779810802;12038.819417708917;12330.81503777426;12474.937625311815;12655;11387.487563059847;11468.197226194086;11641.941790290994;11872.643820685393;11930.463129159381;11433.59982400612;11785.587504437304;11816.86680141111;11874.990625796903;12352.135350525377;11681.824772628248;11785;11877.168598198043;11899.583514576949;12086.033117350767;8549.401541892008;8629.180227878342;8930.464172149692;9127.132922372364;9368.57841397125;9119.726408207764;11048.779024419628;11231.887681123411;11463.770724585629;11471.541138354707 02:53:07 INFO - PROCESS | 1647 | __end_tp_report 02:53:07 INFO - PROCESS | 1647 | __start_cc_report 02:53:07 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,364 02:53:07 INFO - PROCESS | 1647 | __end_cc_report 02:53:07 INFO - PROCESS | 1647 | __startTimestamp1483959187620__endTimestamp 02:53:07 INFO - PROCESS | 1647 | 02:53:07 INFO - PROCESS | 1647 | ------- Summary: start ------- 02:53:07 INFO - PROCESS | 1647 | Number of tests: 6 02:53:07 INFO - PROCESS | 1647 | 02:53:07 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5763.91 Median:6004.97 stddev:642.90 (10.7%) stddev-sans-first:616.85 02:53:07 INFO - PROCESS | 1647 | Values: 3370.7 3396.5 3422.4 3440.9 3489.6 5728.6 5792.4 5846.2 5913.2 5919.2 5883.8 5909.4 5910.0 5950.8 5971.0 5253.8 5284.1 5343.6 5362.5 5365.1 5358.4 5367.9 5379.1 5385.4 5460.4 5241.1 5246.2 5365.8 5369.8 5384.8 5269.8 5294.8 5301.6 5312.5 5343.8 5031.2 5169.8 5196.4 5226.2 5366.0 5730.9 5738.3 5750.7 5758.2 5793.9 5123.8 5125.5 6137.2 6142.8 6210.2 5124.9 5291.3 6279.0 6289.6 6300.2 6000.1 6000.9 6005.0 6006.0 6012.1 6141.9 6227.0 6274.2 6337.8 6365.7 6186.4 6220.7 6225.5 6245.5 6318.0 5609.8 5891.8 6227.8 6263.7 6267.5 5045.6 6200.0 6210.5 6232.7 6252.7 4986.7 6128.5 6128.6 6161.5 6184.5 4902.3 4905.8 4909.5 4911.4 4921.5 4409.6 4426.7 4432.7 4437.6 4441.7 5727.8 5851.0 5859.7 5956.4 5980.0 6215.2 6233.7 6252.4 6278.4 6283.6 5716.5 5832.8 5978.4 6013.1 6102.3 5385.2 5430.0 5431.6 5432.6 5526.2 6415.5 6431.0 6448.2 6457.2 6465.5 5175.3 6221.6 6274.6 6286.0 6300.8 6298.4 6313.5 6389.0 6437.8 6458.6 6247.2 6257.6 6258.2 6260.3 6260.4 6176.1 6247.8 6249.6 6265.0 6269.6 6057.7 6152.4 6162.4 6171.3 6202.4 5982.7 6233.2 6235.3 6236.6 6254.5 5338.1 5893.6 6026.6 6058.1 6151.6 6071.3 6101.9 6130.7 6144.5 6160.6 6021.3 6055.8 6093.6 6134.6 6143.5 02:53:07 INFO - PROCESS | 1647 | 02:53:07 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:73787.21 Median:39554.30 stddev:165036.86 (417.2%) stddev-sans-first:165408.07 02:53:07 INFO - PROCESS | 1647 | Values: 485.2 487.8 524.7 525.2 529.2 37960.1 39646.0 39687.0 39768.8 39984.8 40823.0 40842.6 41310.8 41371.4 41418.6 9272.8 9444.2 9467.7 9488.6 9543.5 7786.8 8167.5 8665.6 8979.7 9387.6 9467.4 9478.5 9498.9 9498.9 9521.5 7999.0 9399.2 9468.1 9477.7 9500.9 9272.4 9301.3 9322.3 9331.6 9355.0 39074.8 39509.6 39510.0 39518.6 39590.0 3453.0 3557.9 3561.7 3758.7 3995.5 29361.1 29633.0 29869.4 30397.4 30416.4 3075.3 3174.7 3187.4 3189.3 3194.5 530155.0 536955.0 540862.0 543460.0 545494.0 61872.0 61996.4 62197.4 62369.4 62647.1 52921.7 64012.0 65411.0 65671.0 65699.3 15954.4 16075.6 16239.8 16264.8 16265.7 12314.1 12383.0 12399.7 12431.4 12472.8 15757.9 17428.5 18260.9 18626.8 18853.9 3170.8 6272.9 7626.2 7672.7 7789.4 817.4 1000.0 1004.0 1024.7 1054.4 28585.7 29525.6 29749.6 30277.5 30464.4 867.4 1008.8 1018.8 1046.1 1124.4 14947.7 15344.1 15489.5 15612.5 15711.9 656452.0 662081.0 664248.0 665201.0 668587.0 56953.4 57091.9 57176.4 57410.4 57525.0 1318.2 1347.5 1362.6 1364.9 1372.1 25252.7 28988.4 29503.3 29914.6 30003.8 55162.4 55854.2 55879.0 55886.0 56076.7 633144.0 634138.0 641588.0 642601.0 643333.0 25215.5 25963.7 26021.0 42283.0 42594.0 44196.0 44703.3 44749.1 44802.8 45044.8 32026.8 32103.2 32994.0 36429.0 37356.3 36766.3 36776.6 37067.6 37790.6 37798.8 35305.8 35850.5 36489.3 36534.6 36802.0 31818.5 33347.8 33833.0 33914.5 34103.5 24871.0 24877.8 25307.0 25478.6 25516.6 02:53:07 INFO - PROCESS | 1647 | 02:53:07 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:35481.21 Median:2789.10 stddev:105235.13 (3773.1%) stddev-sans-first:105497.23 02:53:07 INFO - PROCESS | 1647 | Values: 323.8 378.3 389.6 391.6 412.0 14617.2 14935.6 15772.4 16660.3 17737.6 16226.6 18522.4 19071.0 20027.5 20153.8 5218.6 5486.2 5491.6 5497.5 5512.4 5236.6 5404.4 5422.2 5465.4 5480.2 4452.2 5043.9 5421.1 5446.7 5460.9 5264.0 5418.1 5437.2 5483.8 5488.5 5298.0 5303.0 5344.4 5365.3 5374.2 13242.1 13375.1 13537.0 13705.4 13708.2 2296.6 2301.5 2584.5 2993.7 3006.1 10167.1 10550.2 12115.2 12712.9 14723.2 1845.8 1849.2 1851.7 1852.3 1876.7 124013.0 127928.4 131079.0 133081.7 133392.3 11573.6 11747.9 11771.8 11793.8 11853.5 14889.8 14907.7 14912.7 14915.6 14919.2 7600.5 8051.8 8363.2 8481.0 8618.2 8300.5 8320.9 8327.3 8435.7 8441.4 4431.9 4573.3 4573.5 4631.8 4676.1 1578.5 1795.5 1975.8 1977.2 2034.4 710.0 787.4 845.6 874.3 961.8 16117.7 20564.0 20637.4 20741.0 20797.5 910.1 923.0 938.2 962.6 1021.5 7080.7 10963.9 10976.8 10981.8 11006.1 623106.0 627636.0 628404.0 633258.0 637730.0 118697.0 120852.0 130961.0 132107.0 138727.3 893.2 986.0 1013.6 1023.5 1036.3 18235.0 18259.3 18475.4 18475.7 18617.1 52431.0 52815.9 53096.0 54118.5 54517.0 72420.0 72644.6 73791.0 74508.3 74517.3 8020.4 8064.0 8088.4 8247.2 8343.0 8087.6 11076.5 12334.0 12509.5 12602.0 10592.6 10775.8 10799.0 11039.3 11374.1 9490.4 10605.9 10730.4 10882.6 10928.2 9268.7 10869.7 11007.5 11427.1 11456.6 7061.3 7129.3 7386.4 7418.4 8434.1 8498.6 9961.5 10450.2 10466.5 11338.9 02:53:07 INFO - PROCESS | 1647 | 02:53:07 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5335.94 Median:5101.57 stddev:2943.23 (57.7%) stddev-sans-first:2937.06 02:53:07 INFO - PROCESS | 1647 | Values: 1458.5 1489.2 1669.2 1728.8 1779.3 7565.6 7820.6 8098.5 8542.9 8543.2 7015.2 8030.2 8057.4 8335.2 8405.1 2295.2 2312.9 2327.6 2328.3 2331.8 1773.5 2316.5 2353.8 2355.4 2372.9 2052.5 2205.3 2259.1 2284.0 2288.9 2277.1 2287.4 2309.1 2319.9 2322.9 2272.3 2299.4 2299.5 2302.8 2309.5 8193.6 8226.9 8278.7 8287.1 8299.9 4998.4 5146.9 5150.9 5151.2 5173.3 3132.9 3222.2 3545.5 3550.4 3567.4 919.3 1012.9 1076.2 1089.3 1096.2 10516.9 10828.5 10849.1 10868.9 11075.8 4342.1 4404.8 4501.2 4539.5 4544.3 8619.2 8702.2 8706.3 8713.8 8725.7 4339.4 5082.7 5120.5 5126.1 5128.8 4245.9 4344.8 4629.8 4774.3 4853.5 3422.1 3502.6 3619.1 3670.2 3752.0 1111.1 1113.3 1114.5 1121.0 1126.6 745.8 847.3 883.0 896.2 922.3 5464.9 5516.8 5519.3 5713.7 5739.5 851.6 866.8 902.5 906.3 945.3 3595.4 3774.9 3781.2 3894.0 3895.2 9852.7 10044.8 10236.9 10254.1 10271.3 8358.4 10189.9 10195.0 10200.5 10204.8 7546.0 7779.6 7818.7 7955.1 7964.8 4783.3 5346.7 5434.6 5463.8 5656.5 9274.1 9325.7 9334.4 9422.0 9468.7 8049.0 9494.0 9494.8 9578.4 9701.0 6278.2 6469.1 6564.7 6622.4 6711.7 7818.4 7986.9 8021.8 8027.4 8035.8 6186.6 6336.9 6350.7 7182.2 7190.8 6056.8 6987.5 7056.6 7071.8 7100.0 6569.4 6586.6 6624.3 6638.8 6677.5 4703.2 4707.8 4801.4 4843.5 4862.1 4343.6 4514.8 4821.8 4849.3 4854.2 02:53:07 INFO - PROCESS | 1647 | 02:53:07 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4391.66 Median:4912.43 stddev:1341.92 (27.3%) stddev-sans-first:1310.16 02:53:07 INFO - PROCESS | 1647 | Values: 305.2 306.1 309.8 314.5 318.7 4175.0 4712.0 5318.4 5395.2 5419.3 4933.1 5063.2 5163.7 5241.3 5343.6 3551.5 3584.4 4046.5 4075.5 4154.9 3863.3 3994.4 4063.7 4065.3 4080.4 3453.4 3493.6 4027.9 4045.9 4074.4 3942.0 4057.5 4059.8 4073.5 4087.5 3282.7 3536.7 3557.5 3564.6 3581.9 4788.0 5135.9 5140.4 5142.9 5178.0 4034.9 4572.3 4580.7 4593.6 4609.7 5605.7 5610.7 5614.0 5621.4 5638.4 3557.9 3773.5 3832.7 3853.7 3870.9 4922.0 5584.3 5836.0 5852.1 5857.5 3855.2 3858.4 3864.2 3868.9 3873.9 3499.9 3678.5 3723.7 3940.4 3948.1 4132.7 4195.5 4479.3 4562.4 4607.3 4737.1 5654.8 5679.4 5685.6 5696.9 1096.8 1214.8 1220.8 1232.4 1270.8 781.9 854.8 863.8 868.4 878.9 4197.0 4538.3 4615.5 4776.1 4985.4 4902.9 4983.6 5291.4 5459.3 5488.9 4946.2 5335.2 5352.8 5378.4 5419.9 2439.9 2546.9 2786.7 2868.1 2886.5 4726.8 4950.4 5257.5 5455.4 5680.0 4834.0 4865.8 5035.8 5226.7 5257.9 5213.9 5214.6 5581.0 5652.9 5713.9 4443.5 4763.6 4825.0 5438.5 5545.4 4665.1 5222.5 5266.4 5416.6 5432.6 5043.5 5653.6 5658.6 5667.3 5675.7 3183.6 3189.5 3269.3 3468.8 3692.3 5413.3 5443.6 5461.9 5467.8 5498.5 4760.5 5270.4 5293.4 5295.5 5299.1 4729.3 4871.5 4930.9 5113.6 5291.7 4256.5 5070.0 5289.9 5439.6 5507.2 4744.8 5571.7 5582.0 5599.5 5626.4 5257.7 5418.1 5439.8 5445.9 5451.0 02:53:07 INFO - PROCESS | 1647 | 02:53:07 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:19401.43 Median:57237.21 stddev:28100.56 (49.1%) stddev-sans-first:28144.16 02:53:07 INFO - PROCESS | 1647 | Values: 662.6 669.2 724.4 727.9 781.4 13949.3 14652.6 14666.8 14684.4 14778.6 11355.6 13305.7 13474.3 15018.8 15072.7 808.5 826.8 834.5 834.5 835.7 677.9 689.9 818.9 820.4 823.2 824.7 870.8 871.1 873.2 874.4 845.8 855.1 864.0 864.8 869.4 618.6 641.0 643.4 652.5 656.2 12679.7 13410.1 13982.0 13996.9 14011.3 13406.7 13583.9 13822.0 13827.4 13875.3 11282.1 11336.6 11434.4 11491.5 11508.9 3625.2 3679.2 3688.5 3699.8 3720.5 90321.5 91305.5 91941.0 92335.1 92658.5 8940.4 10363.4 10416.5 10835.2 10897.1 21118.0 21118.6 21127.4 21170.2 21185.4 6494.9 6529.6 7415.3 7452.4 7735.4 4179.2 4181.6 4207.5 4280.0 4383.5 3335.9 3448.8 3480.9 3577.2 3752.2 609.8 627.6 667.9 687.7 690.4 569.2 587.9 649.8 669.4 710.1 8936.0 9060.4 9201.6 9269.0 9299.7 579.6 586.3 621.7 634.1 637.2 3605.9 4267.7 4300.4 4315.4 4417.6 51247.4 68589.7 68937.7 69741.6 103119.5 94427.0 94455.5 96897.0 99295.0 100515.0 83122.0 83791.6 85105.6 85600.7 87878.0 8434.5 8537.5 8561.3 8650.8 8653.6 45330.9 56182.7 57002.0 57472.4 57476.8 44649.0 78519.0 79299.0 80832.6 82787.6 11330.6 11336.0 11411.1 11514.1 11522.5 11924.4 12038.8 12330.8 12474.9 12655.0 11387.5 11468.2 11641.9 11872.6 11930.5 11433.6 11785.6 11816.9 11875.0 12352.1 11681.8 11785.0 11877.2 11899.6 12086.0 8549.4 8629.2 8930.5 9127.1 9368.6 9119.7 11048.8 11231.9 11463.8 11471.5 02:53:07 INFO - PROCESS | 1647 | -------- Summary: end -------- 02:53:07 INFO - PROCESS | 1647 | 02:53:08 INFO - TEST-INFO | 1647: exit 0 02:53:08 INFO - TEST-OK | dromaeo_css | took 1116838ms 02:53:08 INFO - TEST-START | kraken 02:53:08 INFO - operating with platform_type : mac_ 02:53:08 INFO - Initialising browser for kraken test... 02:53:08 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpoUSA39/profile http://localhost:49253/getInfo.html) 02:53:11 INFO - PROCESS | 1655 | 2017-01-09 02:53:11.592 plugin-container[1656:11549] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x463f, name = 'com.apple.tsm.portname' 02:53:11 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:53:11 INFO - PROCESS | 1655 | 2017-01-09 02:53:11.595 plugin-container[1656:11549] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8733, name = 'com.apple.CFPasteboardClient' 02:53:11 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:53:11 INFO - PROCESS | 1655 | 2017-01-09 02:53:11.595 plugin-container[1656:11549] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:53:11 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 02:53:11 INFO - PROCESS | 1655 | colorDepth:24 02:53:11 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 02:53:11 INFO - PROCESS | 1655 | __metrics 02:53:11 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 02:53:12 INFO - TEST-INFO | 1655: exit 0 02:53:12 INFO - Browser initialized. 02:53:12 INFO - Running cycle 1/1 for kraken test... 02:53:12 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpoUSA39/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:15 INFO - PROCESS | 1657 | 2017-01-09 02:53:15.063 plugin-container[1658:11670] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x874b, name = 'com.apple.tsm.portname' 02:53:15 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:53:15 INFO - PROCESS | 1657 | 2017-01-09 02:53:15.063 plugin-container[1658:11670] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0f, name = 'com.apple.CFPasteboardClient' 02:53:15 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:53:15 INFO - PROCESS | 1657 | 2017-01-09 02:53:15.063 plugin-container[1658:11670] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:53:24 INFO - PROCESS | 1657 | RSS: Main: 229830656 02:53:24 INFO - PROCESS | 1657 | 02:53:27 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection) 02:53:28 INFO - PROCESS | 1657 | RSS: Main: 241750016 02:53:28 INFO - PROCESS | 1657 | 02:53:31 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-dft) 02:53:32 INFO - PROCESS | 1657 | RSS: Main: 249499648 02:53:32 INFO - PROCESS | 1657 | 02:53:35 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-fft) 02:53:35 INFO - PROCESS | 1657 | RSS: Main: 253054976 02:53:35 INFO - PROCESS | 1657 | 02:53:37 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator) 02:53:38 INFO - PROCESS | 1657 | RSS: Main: 254423040 02:53:38 INFO - PROCESS | 1657 | 02:53:40 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:53:41 INFO - PROCESS | 1657 | RSS: Main: 254423040 02:53:41 INFO - PROCESS | 1657 | 02:53:44 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom) 02:53:44 INFO - PROCESS | 1657 | RSS: Main: 258519040 02:53:44 INFO - PROCESS | 1657 | 02:53:47 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate) 02:53:48 INFO - PROCESS | 1657 | RSS: Main: 258351104 02:53:48 INFO - PROCESS | 1657 | 02:53:51 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial) 02:53:51 INFO - PROCESS | 1657 | RSS: Main: 258596864 02:53:51 INFO - PROCESS | 1657 | 02:53:53 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:53:54 INFO - PROCESS | 1657 | RSS: Main: 257482752 02:53:54 INFO - PROCESS | 1657 | 02:53:55 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:53:56 INFO - PROCESS | 1657 | RSS: Main: 257556480 02:53:56 INFO - PROCESS | 1657 | 02:53:58 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:59 INFO - PROCESS | 1657 | RSS: Main: 258080768 02:53:59 INFO - PROCESS | 1657 | 02:54:02 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:54:03 INFO - PROCESS | 1657 | RSS: Main: 257613824 02:54:03 INFO - PROCESS | 1657 | 02:54:05 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:54:06 INFO - PROCESS | 1657 | RSS: Main: 257949696 02:54:06 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49253/tests/kraken/driver.html?testName=ai-astar) 02:54:08 INFO - PROCESS | 1657 | RSS: Main: 259608576 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | __start_tp_report 02:54:08 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 02:54:08 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 02:54:08 INFO - PROCESS | 1657 | |i|pagename|runs| 02:54:08 INFO - PROCESS | 1657 | |0;ai-astar;111;117;116;117;117;117;164;162;115;134 02:54:08 INFO - PROCESS | 1657 | |1;audio-beat-detection;144;112;111;149;113;116;144;101;185;121 02:54:08 INFO - PROCESS | 1657 | |2;audio-dft;195;198;197;198;194;195;199;196;199;199 02:54:08 INFO - PROCESS | 1657 | |3;audio-fft;84;57;60;86;60;59;54;77;69;75 02:54:08 INFO - PROCESS | 1657 | |4;audio-oscillator;90;70;85;73;54;81;122;85;103;120 02:54:08 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;87;86;87;101;76;126;134;133;88;85 02:54:08 INFO - PROCESS | 1657 | |6;imaging-darkroom;102;95;94;92;152;150;95;96;93;93 02:54:08 INFO - PROCESS | 1657 | |7;imaging-desaturate;108;100;86;93;133;87;91;89;87;87 02:54:08 INFO - PROCESS | 1657 | |8;json-parse-financial;56;57;57;58;59;61;61;59;61;60 02:54:08 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;69;74;78;79;76;71;73;72;71;71 02:54:08 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;97;87;85;84;86;84;85;90;84;85 02:54:08 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;140;141;139;141;146;143;159;157;202;143 02:54:08 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;246;183;165;173;167;169;170;168;171;169 02:54:08 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;69;68;69;70;71;65;68;68;69;69 02:54:08 INFO - PROCESS | 1657 | __end_tp_report 02:54:08 INFO - PROCESS | 1657 | __start_cc_report 02:54:08 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1011 02:54:08 INFO - PROCESS | 1657 | __end_cc_report 02:54:08 INFO - PROCESS | 1657 | __startTimestamp1483959248551__endTimestamp 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | ------- Summary: start ------- 02:54:08 INFO - PROCESS | 1657 | Number of tests: 14 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:127.00 Median:117.00 stddev:19.90 (17.0%) stddev-sans-first:20.25 02:54:08 INFO - PROCESS | 1657 | Values: 111.0 117.0 116.0 117.0 117.0 117.0 164.0 162.0 115.0 134.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:132.50 stddev:25.54 (19.3%) stddev-sans-first:26.55 02:54:08 INFO - PROCESS | 1657 | Values: 144.0 112.0 111.0 149.0 113.0 116.0 144.0 101.0 185.0 121.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:197.00 Median:198.00 stddev:1.89 (1.0%) stddev-sans-first:1.86 02:54:08 INFO - PROCESS | 1657 | Values: 195.0 198.0 197.0 198.0 194.0 195.0 199.0 196.0 199.0 199.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:68.10 Median:72.00 stddev:11.72 (16.3%) stddev-sans-first:10.93 02:54:08 INFO - PROCESS | 1657 | Values: 84.0 57.0 60.0 86.0 60.0 59.0 54.0 77.0 69.0 75.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:77.00 stddev:21.55 (28.0%) stddev-sans-first:22.85 02:54:08 INFO - PROCESS | 1657 | Values: 90.0 70.0 85.0 73.0 54.0 81.0 122.0 85.0 103.0 120.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:100.30 Median:85.50 stddev:22.11 (25.9%) stddev-sans-first:22.92 02:54:08 INFO - PROCESS | 1657 | Values: 87.0 86.0 87.0 101.0 76.0 126.0 134.0 133.0 88.0 85.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:106.20 Median:93.50 stddev:23.78 (25.4%) stddev-sans-first:25.17 02:54:08 INFO - PROCESS | 1657 | Values: 102.0 95.0 94.0 92.0 152.0 150.0 95.0 96.0 93.0 93.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:87.00 stddev:14.74 (16.9%) stddev-sans-first:14.99 02:54:08 INFO - PROCESS | 1657 | Values: 108.0 100.0 86.0 93.0 133.0 87.0 91.0 89.0 87.0 87.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.50 stddev:1.85 (3.1%) stddev-sans-first:1.64 02:54:08 INFO - PROCESS | 1657 | Values: 56.0 57.0 57.0 58.0 59.0 61.0 61.0 59.0 61.0 60.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:73.50 stddev:3.31 (4.5%) stddev-sans-first:3.10 02:54:08 INFO - PROCESS | 1657 | Values: 69.0 74.0 78.0 79.0 76.0 71.0 73.0 72.0 71.0 71.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.50 stddev:4.06 (4.7%) stddev-sans-first:1.94 02:54:08 INFO - PROCESS | 1657 | Values: 97.0 87.0 85.0 84.0 86.0 84.0 85.0 90.0 84.0 85.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:144.50 stddev:19.20 (13.3%) stddev-sans-first:19.94 02:54:08 INFO - PROCESS | 1657 | Values: 140.0 141.0 139.0 141.0 146.0 143.0 159.0 157.0 202.0 143.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.10 Median:170.50 stddev:24.36 (14.3%) stddev-sans-first:5.20 02:54:08 INFO - PROCESS | 1657 | Values: 246.0 183.0 165.0 173.0 167.0 169.0 170.0 168.0 171.0 169.0 02:54:08 INFO - PROCESS | 1657 | 02:54:08 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.58 (2.3%) stddev-sans-first:1.67 02:54:08 INFO - PROCESS | 1657 | Values: 69.0 68.0 69.0 70.0 71.0 65.0 68.0 68.0 69.0 69.0 02:54:08 INFO - PROCESS | 1657 | -------- Summary: end -------- 02:54:08 INFO - PROCESS | 1657 | 02:54:09 INFO - TEST-INFO | 1657: exit 0 02:54:09 INFO - TEST-OK | kraken | took 61155ms 02:54:09 INFO - SUITE-END | took 1177s 02:54:09 INFO - Completed test suite (00:19:38) 02:54:09 INFO - javascript benchmark 02:54:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7073.904443851633, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.730341572674, 3396.5075064115704, 3422.418188907885, 3440.8967730968066, 3489.5638045244345, 5728.598998070137, 5792.420757924206, 5846.152307915349, 5913.2017177681, 5919.200907877435, 5883.823485295437, 5909.379515150912, 5910.0, 5950.79172228972, 5971.044632858743, 5253.816116435925, 5284.075286824809, 5343.625946183769, 5362.490563396491, 5365.141577347626, 5358.3569971603465, 5367.919481207785, 5379.139337705968, 5385.407605163448, 5460.399356070849, 5241.109011468059, 5246.1606143017125, 5365.812196573121, 5369.7583608737705, 5384.838454846361, 5269.762860671279, 5294.841154765363, 5301.5758739301145, 5312.521873031426, 5343.812966546152, 5031.245313203012, 5169.767360468751, 5196.402413722395, 5226.1638137898135, 5365.973170134124, 5730.856728581777, 5738.254026976508, 5750.683712395817, 5758.222639943596, 5793.855153621151, 5123.846284611468, 5125.513076257749, 6137.202163718733, 6142.8364392337535, 6210.1616281801835, 5124.871878203037, 5291.312129423189, 6279.0, 6289.622622642656, 6300.180976473029, 6000.069989151689, 6000.939990600038, 6004.969975150097, 6005.969970150165, 6012.068129439944, 6141.854248382324, 6227.0, 6274.247090349188, 6337.841553961096, 6365.713542890581, 6186.381361863868, 6220.688965551704, 6225.470834978987, 6245.500359971192, 6317.957537006434, 5609.775608975595, 5891.792182602642, 6227.844303892439, 6263.749450021948, 6267.5299352548745, 5045.646804723708, 6200.0, 6210.472109870621, 6232.719527621268, 6252.6873656317, 4986.675866068694, 6128.533679014772, 6128.6016408934165, 6161.476274516626, 6184.474319682788, 4902.313676085351, 4905.754712264373, 4909.484504127086, 4911.386076740408, 4921.458639549646, 4409.603135717736, 4426.675995102532, 4432.667549933768, 4437.622802061796, 4441.733495990251, 5727.825795711869, 5850.970745146247, 5859.707014649251, 5956.404359564009, 5980.0431930890845, 6215.160953271251, 6233.688315584202, 6252.406021427957, 6278.4035516625845, 6283.622982621057, 5716.456936591017, 5832.795852145239, 5978.406885914739, 6013.067974463877, 6102.298235702951, 5385.246065550826, 5430.049741295336, 5431.5926305526455, 5432.565394768488, 5526.226328314039, 6415.486761059104, 6431.0, 6448.193975753031, 6457.192850893733, 6465.450436712838, 5175.327207463006, 6221.595596286227, 6274.592151510137, 6286.0, 6300.84247893788, 6298.401651843067, 6313.494920406449, 6388.968055159695, 6437.839054023687, 6458.580192287486, 6247.219097612799, 6257.56197066201, 6258.217722784652, 6260.342664020212, 6260.373962603885, 6176.104464852661, 6247.781327653511, 6249.625022498664, 6264.968675156595, 6269.62382257066, 6057.697115144313, 6152.354002829638, 6162.414570615784, 6171.290301615192, 6202.41077097675, 5982.7307771149535, 6233.2208473940755, 6235.345288744798, 6236.594621349598, 6254.468370188403, 5338.065838478328, 5893.616914900518, 6026.608270462406, 6058.121572371893, 6151.569390142826, 6071.332153463204, 6101.877962440815, 6130.673316708229, 6144.53915956314, 6160.599561028519, 6021.277446706424, 6055.757769689163, 6093.634381937098, 6134.631922084689, 6143.477804386677], "value": 5725.60682835022, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.2091091520821, 487.8292597590844, 524.685188886668, 525.2174260352076, 529.2352550564436, 37960.05099872505, 39646.0, 39686.99999999996, 39768.80115599418, 39984.80007599965, 40823.0, 40842.59157408433, 41310.76067717973, 41371.37942930851, 41418.58581414192, 9272.768180795483, 9444.244460443182, 9467.668631597895, 9488.573014214342, 9543.522823858813, 7786.754119340907, 8167.509949403055, 8665.566721663892, 8979.65305204218, 9387.62449502019, 9467.431954082742, 9478.478683672396, 9498.857517137249, 9498.905010949906, 9521.476318802463, 7998.960005199937, 9399.201067909236, 9468.100530449665, 9477.668281610111, 9500.857487137699, 9272.350935434522, 9301.302402319852, 9322.30082743797, 9331.580078896466, 9354.953225233898, 39074.80462597697, 39509.60490395088, 39510.0, 39518.604813952064, 39590.0, 3452.982735086334, 3557.928841423183, 3561.661642143992, 3758.699304055669, 3995.5205375355144, 29361.09152905076, 29633.0, 29869.40261194764, 30397.392052159055, 30416.39167216643, 3075.261937135094, 3174.6984036516724, 3187.3943950649536, 3189.2505261263586, 3194.520821876714, 530155.0, 536955.0, 540862.0, 543459.999999996, 545494.0, 61872.0, 61996.38003619906, 62197.37802621916, 62369.37630623727, 62647.12058638248, 52921.7353913228, 64012.03981940181, 65411.0, 65671.0, 65699.34300656932, 15954.441594544136, 16075.598110047342, 16239.837601623833, 16264.83735162657, 16265.674686506203, 12314.076444266715, 12383.0, 12399.690007749878, 12431.37843107859, 12472.750544989049, 15757.896947213585, 17428.51238116703, 18260.904345739298, 18626.78925869814, 18853.86876787397, 3170.793898396597, 6272.905906411407, 7626.199249078878, 7672.698190542815, 7789.3768498519985, 817.38287592867, 1000.0449570660003, 1003.9698809035741, 1024.6721049264313, 1054.3989925742253, 28585.71364288612, 29525.557116643267, 29749.553756693665, 30277.545836812464, 30464.390712185632, 867.4144952157269, 1008.838585826279, 1018.7860549284733, 1046.1264843855313, 1124.4265424633331, 14947.70104597902, 15344.079355238498, 15489.5353139406, 15612.4535641252, 15711.921440392725, 656452.0, 662081.0, 664248.0, 665201.0, 668587.0, 56953.430465694815, 57091.858162836514, 57176.42823571711, 57410.42589574134, 57525.0, 1318.2222488731695, 1347.4677502386503, 1362.5503583817317, 1364.8908087352988, 1372.0944176843434, 25252.74747252504, 28988.42023159567, 29503.26241843885, 29914.606831453868, 30003.849980749957, 55162.448375515734, 55854.16218756803, 55879.0, 55885.99999999837, 56076.71961640166, 633144.0, 634138.0, 641588.0, 642601.0, 643333.0, 25215.495690086464, 25963.74036259613, 26020.95916163408, 42283.0, 42594.0, 44196.0, 44703.329450058925, 44749.10501790011, 44802.77598611986, 45044.77477612591, 32026.83986580052, 32103.23432211251, 32994.0, 36429.0, 37356.252874941805, 36766.264674705824, 36776.63223367732, 37067.62932370749, 37790.62209377981, 37798.81100594479, 35305.82347088248, 35850.4622430669, 36489.27021459503, 36534.63465365312, 36802.0, 31818.522722158723, 33347.83282585195, 33833.0, 33914.49128263029, 34103.4884476738, 24871.0, 24877.751222487543, 25307.0, 25478.617820733074, 25516.617250741627], "value": 19816.060612299545, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.7733586489457, 378.32280218409034, 389.58509187715083, 391.594699486032, 411.9588041195881, 14617.196054217015, 14935.626609334771, 15772.369105235777, 16660.250288737006, 17737.645247095068, 16226.594335141597, 18522.351717689882, 19071.0, 20027.499312517193, 20153.798462015377, 5218.608604354679, 5486.177073438977, 5491.643043202199, 5497.45025497451, 5512.39363669998, 5236.581073514109, 5404.351477822647, 5422.186671999192, 5465.426130256325, 5480.232767412565, 4452.1986042512335, 5043.86513034568, 5421.078416669156, 5446.700431476267, 5460.890782184354, 5263.973680131594, 5418.051840927861, 5437.157240627689, 5483.835484935458, 5488.506034456918, 5298.046351656701, 5303.0, 5344.412114667383, 5365.302510673588, 5374.167004114369, 13242.073054886161, 13375.063745537816, 13537.0, 13705.383257753325, 13708.24604646744, 2296.5636529059593, 2301.4706617478073, 2584.508943300767, 2993.7006299370105, 3006.0981705488266, 10167.135793457564, 10550.15598752098, 12115.15193936416, 12712.936435317857, 14723.190224537646, 1845.833874951261, 1849.1863580024747, 1851.6852135136924, 1852.2590963614527, 1876.6997280435064, 124013.0, 127928.36035819854, 131079.0, 133081.66918330887, 133392.33303833517, 11573.594924177612, 11747.943786024125, 11771.764564708657, 11793.764124717458, 11853.46659400329, 14889.776653350209, 14907.70184596302, 14912.701745965236, 14915.552533424014, 14919.179445130405, 7600.467967242351, 8051.838963220703, 8363.163683631588, 8481.0, 8618.181272779077, 8300.543470109082, 8320.916790832136, 8327.250547450758, 8435.662573497115, 8441.36689748259, 4431.911361772746, 4573.268277075652, 4573.451185857652, 4631.8378856739855, 4676.0647870426055, 1578.5027716269337, 1795.4613615915173, 1975.8221760041665, 1977.1893523655233, 2034.4303594993426, 710.0059916117477, 787.3740376400775, 845.602566793606, 874.3355050161923, 961.8124465729115, 16117.677646447006, 20564.0, 20637.380878573666, 20741.0, 20797.480062998548, 910.0626354854511, 922.9861552076724, 938.2212763406357, 962.629387685746, 1021.4637315409321, 7080.716771329089, 10963.945180274048, 10976.780464390828, 10981.780364392667, 11006.064484518905, 623106.0, 627636.0, 628404.0, 633258.0, 637730.0, 118697.0, 120852.0302204778, 130961.0, 132107.0, 138727.30636346753, 893.2318206342541, 986.0435377683779, 1013.6300250408696, 1023.4575674892319, 1036.3212096077082, 18235.0, 18259.269629214683, 18475.445736627924, 18475.722864156778, 18617.069146542348, 52431.0, 52815.94368112693, 53096.0, 54118.458815411344, 54517.0, 72420.0, 72644.63677681578, 73791.0, 74508.25491745013, 74517.2548274532, 8020.358371330163, 8064.0, 8088.433809633269, 8247.21651443112, 8343.0, 8087.555184464911, 11076.501557430096, 12334.0, 12509.499620015462, 12602.046682764187, 10592.629257975934, 10775.760787509224, 10799.0, 11039.337639741641, 11374.146938979444, 9490.383125096847, 10605.946970265099, 10730.409827459252, 10882.564697412332, 10928.235023548275, 9268.675596354095, 10869.728256793644, 11007.504662290055, 11427.142964277878, 11456.599019034295, 7061.329173728487, 7129.287071292829, 7386.372158366599, 7418.443616728659, 8434.072252052392, 8498.617562209593, 9961.501924903581, 10450.216233782648, 10466.529006194893, 11338.886611134112], "value": 9165.055951391434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.5041086030747, 1489.195834249505, 1669.223810927919, 1728.7666165067728, 1779.3327502186671, 7565.621718914046, 7820.608969551528, 8098.514089154655, 8542.871856922144, 8543.188397102273, 7015.193252775933, 8030.23712747288, 8057.388522295535, 8335.249827515523, 8405.117462666423, 2295.242569951916, 2312.90748370065, 2327.615943369342, 2328.3480625424822, 2331.778481044298, 1773.538879891231, 2316.4903721181313, 2353.752855950118, 2355.352278123521, 2372.881355932205, 2052.5073982244303, 2205.305328821416, 2259.1076524772707, 2284.0, 2288.931332060041, 2277.1119263487253, 2287.4395773035544, 2309.1340747219792, 2319.9188028418926, 2322.93031209064, 2272.2728726807427, 2299.379167624732, 2299.482616411294, 2302.82728795341, 2309.457277539777, 8193.590320484012, 8226.876596850992, 8278.710245141452, 8287.12985136564, 8299.917000829975, 4998.375203099613, 5146.9485305146845, 5150.871228219325, 5151.227315902607, 5173.3016042834115, 3132.903483780681, 3222.1622378181605, 3545.503629491873, 3550.431930891071, 3567.4292113261754, 919.3105171121658, 1012.8835183953793, 1076.160594736107, 1089.2810744908402, 1096.2435919215716, 10516.894831051668, 10828.458577071193, 10849.077828384598, 10868.891311086945, 11075.833862491989, 4342.08816148606, 4404.801783919731, 4501.234790085693, 4539.500654927955, 4544.272916333371, 8619.224269815746, 8702.173293537104, 8706.259967902672, 8713.825723485621, 8725.694600689072, 4339.392485052095, 5082.669626474268, 5120.462351453044, 5126.051680439131, 5128.820491282861, 4245.915081698348, 4344.847930322424, 4629.837955671535, 4774.3077253798, 4853.490383509751, 3422.144463884029, 3502.581454510927, 3619.149499867529, 3670.2292518570866, 3751.981240093782, 1111.127764704719, 1113.3375641493299, 1114.5207560748793, 1121.0247085036071, 1126.5550107707409, 745.7911784700184, 847.3009766942174, 882.9779255518534, 896.2202883491404, 922.31748506105, 5464.907018596296, 5516.806911758069, 5519.31008623922, 5713.6857472838565, 5739.540836733051, 851.6465666748354, 866.8179682266795, 902.5261737587688, 906.3247880329197, 945.3099237556622, 3595.352836489457, 3774.8867533974026, 3781.2248489059675, 3893.980530097388, 3895.220955808793, 9852.655157069468, 10044.849327260097, 10236.948815256024, 10254.128399086012, 10271.281010329354, 8358.414910956175, 10189.898101018895, 10195.0, 10200.489975501196, 10204.795904082026, 7546.019017527687, 7779.572123533147, 7818.68725250995, 7955.0851652060755, 7964.800879978047, 4783.282507623884, 5346.663334166458, 5434.64674796137, 5463.836084917459, 5656.490915817596, 9274.072592740671, 9325.673601423918, 9334.439933603733, 9422.0, 9468.668596599086, 8049.0, 9494.0, 9494.810103798023, 9578.425294482353, 9700.951495242478, 6278.246610406781, 6469.061986012096, 6564.737410503526, 6622.403983641495, 6711.664416779239, 7818.374530037697, 7986.881836542772, 8021.799455013438, 8027.357811375193, 8035.758927232192, 6186.628802271878, 6336.859365314288, 6350.68246587678, 7182.245864184186, 7190.784276471505, 6056.818295451144, 6987.475939304471, 7056.647167641495, 7071.7878463646175, 7100.0, 6569.37590928861, 6586.604803711793, 6624.271330153776, 6638.83402914931, 6677.465802735866, 4703.223968045234, 4707.835225767081, 4801.423829140525, 4843.467218606021, 4862.149123903232, 4343.630791382768, 4514.796834142406, 4821.807127714852, 4849.296851956376, 4854.1747902857305], "value": 4320.2603937633885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.1699377692677, 306.11837906828333, 309.7939869986459, 314.5250671486056, 318.6876860676537, 4174.979125104378, 4712.0, 5318.414974352818, 5395.163749618815, 5419.26839876617, 4933.062718083562, 5063.189889617662, 5163.690178589287, 5241.266222728821, 5343.599230057742, 3551.5205447264675, 3584.372734771405, 4046.502793966237, 4075.49056367954, 4154.940490175001, 3863.285292220934, 3994.406644826884, 4063.6545893599077, 4065.26825171469, 4080.4092398689113, 3453.4129198036267, 3493.637481382263, 4027.8791636250958, 4045.858394956177, 4074.370251899249, 3942.014496375906, 4057.5130984282073, 4059.7564146151326, 4073.452088206492, 4087.5299340575916, 3282.7045565899184, 3536.664016918389, 3557.5019497270405, 3564.625714299987, 3581.94627080594, 4788.0, 5135.948640513584, 5140.357455318085, 5142.948570514284, 5178.0, 4034.910574144994, 4572.268437050089, 4580.656450766206, 4593.586577208034, 4609.723416595015, 5605.663660180402, 5610.69141197234, 5613.989481893258, 5621.381648018714, 5638.351589567212, 3557.8576856925692, 3773.5094637618263, 3832.677726184462, 3853.6531712146043, 3870.8838734838, 4921.975390123026, 5584.274044374246, 5836.0, 5852.122181672783, 5857.47282744555, 3855.1904100139286, 3858.401947698111, 3864.246471937945, 3868.903277418031, 3873.9418908716393, 3499.9475007874903, 3678.5401824771902, 3723.6834869035893, 3940.369540873504, 3948.052467407859, 4132.710710250314, 4195.517515485697, 4479.328100784908, 4562.384078149474, 4607.3319368691355, 4737.147313483537, 5654.802081927113, 5679.375268720438, 5685.630434021776, 5696.8860622787315, 1096.7587130831205, 1214.7509760499076, 1220.7680540697238, 1232.3653318540958, 1270.7585558743808, 781.9100803407681, 854.8416895107165, 863.7797361672733, 868.4398562927003, 878.9077146899483, 4197.047483968946, 4538.341940418621, 4615.515370886009, 4776.116418462596, 4985.376827896513, 4902.877428064256, 4983.626228032912, 5291.365036195682, 5459.262999495097, 5488.862778430571, 4946.233333833262, 5335.2393710075585, 5352.759125839347, 5378.435264297193, 5419.945800542023, 2439.8902049407466, 2546.9235922922344, 2786.70739572346, 2868.0965495868736, 2886.466003789306, 4726.763661816895, 4950.356453661073, 5257.526822585985, 5455.372632147274, 5679.983605819957, 4834.0331933612715, 4865.829695960624, 5035.79856805731, 5226.661870647354, 5257.868553286198, 5213.921791173136, 5214.567617525225, 5580.972095139579, 5652.943470565242, 5713.914421236219, 4443.466783985813, 4763.595094417014, 4824.986752781955, 5438.450041738086, 5545.390007099297, 4665.090307390162, 5222.503862133091, 5266.368035835724, 5416.620836541404, 5432.56539476833, 5043.519971219846, 5653.604247702621, 5658.575606829587, 5667.263255776723, 5675.744591493475, 3183.5543023977125, 3189.4737368333963, 3269.2807582331848, 3468.7745296555645, 3692.2800053989213, 5413.323334583177, 5443.646162999393, 5461.945380546303, 5467.781288748405, 5498.477644623755, 4760.452547956891, 5270.4202537721585, 5293.411976406986, 5295.523402893758, 5299.092326762286, 4729.314249433744, 4871.537203965618, 4930.91519865629, 5113.590912727047, 5291.708956007456, 4256.510501292391, 5069.9746501267255, 5289.9471005291, 5439.564834813126, 5507.228987941611, 4744.82096995021, 5571.749271282721, 5582.0, 5599.468050535193, 5626.409227031103, 5257.710825904612, 5418.133098704188, 5439.809606663748, 5445.945540544702, 5451.0], "value": 3962.3551827387955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.6090606542139, 669.1568623534347, 724.3842733676375, 727.8689835829549, 781.4100354232554, 13949.302534873254, 14652.633684157874, 14666.779998300033, 14684.412623495075, 14778.630534236636, 11355.602553910594, 13305.733885322312, 13474.326283685825, 15018.774718379233, 15072.6985460291, 808.462372522272, 826.8346330733847, 834.4659417972503, 834.5034704350901, 835.7492752174354, 677.8542613338132, 689.8516818883938, 818.9467684600512, 820.3683163963744, 823.2467292427451, 824.6989848705209, 870.7735988642967, 871.1027641529236, 873.2097451806094, 874.396666300254, 845.7674139611595, 855.1234984141242, 864.0409145848104, 864.7665130414815, 869.4305230074311, 618.5670030978288, 640.9679516024227, 643.4177069751883, 652.5236577298551, 656.186328952096, 12679.746405071939, 13410.128341657859, 13982.0, 13996.860031399658, 14011.29943502831, 13406.664833379145, 13583.864161358359, 13822.0, 13827.377768000464, 13875.306234688225, 11282.097432205404, 11336.603218887381, 11434.428278586038, 11491.540338386454, 11508.942455287754, 3625.220577575834, 3679.19057807282, 3688.5204923359793, 3699.815009249554, 3720.534933133358, 90321.54839225762, 91305.54347228288, 91941.0, 92335.07664923399, 92658.5367073167, 8940.3741738079, 10363.430011349448, 10416.531256093494, 10835.241533092765, 10897.128229741602, 21118.049687764087, 21118.577628447652, 21127.366179014654, 21170.153193872382, 21185.364439066852, 6494.870102597922, 6529.575577587441, 7415.3326200642205, 7452.403807695479, 7735.419843511759, 4179.185058913483, 4181.623653871166, 4207.453031105937, 4279.957200427956, 4383.473983122046, 3335.93328133436, 3448.8448019839166, 3480.912977175591, 3577.177249232691, 3752.1745216052423, 609.841301527102, 627.6485168305763, 667.9298673639295, 687.7317846040048, 690.4062506244626, 569.1945896556409, 587.8824235152987, 649.7530938243438, 669.363406471183, 710.1052673631159, 8936.0, 9060.411073280216, 9201.585928633227, 9269.026752190923, 9299.72100836976, 579.6493121661418, 586.3432955090326, 621.7077973352608, 634.0647544871277, 637.2448648351718, 3605.8737944171826, 4267.722598031118, 4300.397944287803, 4315.438992930899, 4417.558244175557, 51247.437628118445, 68589.65705171542, 68937.65531172413, 69741.55904543317, 103119.48440257751, 94427.0, 94455.52772236094, 96897.0, 99295.0, 100515.0, 83122.0, 83791.5810420944, 85105.57447212849, 85600.71598926146, 87878.0, 8434.493930364199, 8537.50593646097, 8561.315094792277, 8650.78373040679, 8653.567321634018, 45330.866728332054, 56182.71908640431, 57002.0, 57472.425275746704, 57476.82386134663, 44649.0, 78519.0, 79299.0, 80832.59583702043, 82787.5860620693, 11330.60342887995, 11336.0, 11411.144164187554, 11514.078873689918, 11522.53909843597, 11924.403779810802, 12038.819417708917, 12330.81503777426, 12474.937625311815, 12655.0, 11387.487563059847, 11468.197226194086, 11641.941790290994, 11872.643820685393, 11930.463129159381, 11433.59982400612, 11785.587504437304, 11816.86680141111, 11874.990625796903, 12352.135350525377, 11681.824772628248, 11785.0, 11877.168598198043, 11899.583514576949, 12086.033117350767, 8549.401541892008, 8629.180227878342, 8930.464172149692, 9127.132922372364, 9368.57841397125, 9119.726408207764, 11048.779024419628, 11231.887681123411, 11463.770724585629, 11471.541138354707], "value": 7038.323616401167, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 117.0, 116.0, 117.0, 117.0, 117.0, 164.0, 162.0, 115.0, 134.0], "value": 127.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 111.0, 149.0, 113.0, 116.0, 144.0, 101.0, 185.0, 121.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 198.0, 197.0, 198.0, 194.0, 195.0, 199.0, 196.0, 199.0, 199.0], "value": 197.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 57.0, 60.0, 86.0, 60.0, 59.0, 54.0, 77.0, 69.0, 75.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 85.0, 73.0, 54.0, 81.0, 122.0, 85.0, 103.0, 120.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 101.0, 76.0, 126.0, 134.0, 133.0, 88.0, 85.0], "value": 100.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 95.0, 94.0, 92.0, 152.0, 150.0, 95.0, 96.0, 93.0, 93.0], "value": 106.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 100.0, 86.0, 93.0, 133.0, 87.0, 91.0, 89.0, 87.0, 87.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 58.0, 59.0, 61.0, 61.0, 59.0, 61.0, 60.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 78.0, 79.0, 76.0, 71.0, 73.0, 72.0, 71.0, 71.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 87.0, 85.0, 84.0, 86.0, 84.0, 85.0, 90.0, 84.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 139.0, 141.0, 146.0, 143.0, 159.0, 157.0, 202.0, 143.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [246.0, 183.0, 165.0, 173.0, 167.0, 169.0, 170.0, 168.0, 171.0, 169.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 70.0, 71.0, 65.0, 68.0, 68.0, 69.0, 69.0], "value": 68.6, "unit": "score"}]}]} 02:54:09 INFO - Return code: 0 02:54:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:54:09 ERROR - # TBPL SUCCESS # 02:54:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:54:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:54:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:54:09 INFO - 2017-01-09 02:54:09.901 screenresolution[1662:12049] starting screenresolution argv=screenresolution get 02:54:09 INFO - 2017-01-09 02:54:09.905 screenresolution[1662:12049] Display 0: 1600x1200x32@60 02:54:09 INFO - 2017-01-09 02:54:09.911 screenresolution[1663:12052] starting screenresolution argv=screenresolution list 02:54:09 INFO - Available Modes on Display 0 02:54:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:54:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:54:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:54:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:54:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:54:10 INFO - Intel Iris: 02:54:10 INFO - Chipset Model: Intel Iris 02:54:10 INFO - Type: GPU 02:54:10 INFO - Bus: Built-In 02:54:10 INFO - VRAM (Dynamic, Max): 1536 MB 02:54:10 INFO - Vendor: Intel (0x8086) 02:54:10 INFO - Device ID: 0x0a2e 02:54:10 INFO - Revision ID: 0x0009 02:54:10 INFO - Displays: 02:54:10 INFO - Display: 02:54:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:54:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:54:10 INFO - Display Serial Number: 1600x1200 60 02:54:10 INFO - Main Display: Yes 02:54:10 INFO - Mirror: Off 02:54:10 INFO - Online: Yes 02:54:10 INFO - Rotation: Supported 02:54:10 INFO - Return code: 0 02:54:10 INFO - Running post-action listener: _resource_record_post_action 02:54:10 INFO - [mozharness: 2017-01-09 10:54:10.150660Z] Finished run-tests step (success) 02:54:10 INFO - Running post-run listener: _resource_record_post_run 02:54:10 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 34476544; Write bytes: 661762048; Read time: 327; Write time: 2024 02:54:10 INFO - TinderboxPrint: CPU usage
54.4% 02:54:10 INFO - TinderboxPrint: I/O read bytes / time
34,476,544 / 327 02:54:10 INFO - TinderboxPrint: I/O write bytes / time
661,762,048 / 2,024 02:54:10 INFO - TinderboxPrint: CPU idle
2,205.7 (45.6%) 02:54:10 INFO - TinderboxPrint: CPU system
977.5 (20.2%) 02:54:10 INFO - TinderboxPrint: CPU user
1,655.4 (34.2%) 02:54:10 INFO - TinderboxPrint: Swap in / out
380,342,272 / 0 02:54:10 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 334649856; Write bytes: 334411776; Read time: 25684; Write time: 637 02:54:10 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 33550848; Write bytes: 309598208; Read time: 313; Write time: 1333 02:54:10 INFO - Running post-run listener: _upload_blobber_files 02:54:10 INFO - Blob upload gear active. 02:54:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:54:10 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 02:54:10 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'] 02:54:10 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 02:54:11 INFO - (blobuploader) - INFO - Open directory for files ... 02:54:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:54:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:54:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:12 INFO - (blobuploader) - INFO - Done attempting. 02:54:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:54:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:54:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:13 INFO - (blobuploader) - INFO - Done attempting. 02:54:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:54:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:54:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:16 INFO - (blobuploader) - INFO - Done attempting. 02:54:16 INFO - (blobuploader) - INFO - Iteration through files over. 02:54:16 INFO - Return code: 0 02:54:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:54:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:54:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39f48a26c3d9fc90a2ac3d93209d143170e831e29d1cb43a7f5e44cd851534154c4cc33558c44b80c32e39fada1b8efed74ae71397be8eafb515e54aca5d981e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e9c3d4bba06caeef6c7d7ea6c8374a32a0459f6531130b6bec6f84b9e224594c3cc0f142d3245143cbb272052481d3d6f0bf9409d1a484e92acb89a0e6282d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0e4b7b823f58ecc87f112a3266ec31ccbb70d98994d5106b271c97386e6ed160e3bd86e6efa6dacc874b5b613dd2e9d26dc5a05abc22c226ea5d0f2d7931e59"} 02:54:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:54:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:54:16 INFO - Contents: 02:54:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39f48a26c3d9fc90a2ac3d93209d143170e831e29d1cb43a7f5e44cd851534154c4cc33558c44b80c32e39fada1b8efed74ae71397be8eafb515e54aca5d981e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e9c3d4bba06caeef6c7d7ea6c8374a32a0459f6531130b6bec6f84b9e224594c3cc0f142d3245143cbb272052481d3d6f0bf9409d1a484e92acb89a0e6282d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0e4b7b823f58ecc87f112a3266ec31ccbb70d98994d5106b271c97386e6ed160e3bd86e6efa6dacc874b5b613dd2e9d26dc5a05abc22c226ea5d0f2d7931e59"} 02:54:16 INFO - Running post-run listener: copy_logs_to_upload_dir 02:54:16 INFO - Copying logs to upload dir... 02:54:16 INFO - mkdir: /builds/slave/test/build/upload/logs 02:54:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1795.810009 ========= master_lag: 5.41 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 30 mins, 1 secs) (at 2017-01-09 02:54:16.096843) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 02:54:16.100189) ========= 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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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/39f48a26c3d9fc90a2ac3d93209d143170e831e29d1cb43a7f5e44cd851534154c4cc33558c44b80c32e39fada1b8efed74ae71397be8eafb515e54aca5d981e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e9c3d4bba06caeef6c7d7ea6c8374a32a0459f6531130b6bec6f84b9e224594c3cc0f142d3245143cbb272052481d3d6f0bf9409d1a484e92acb89a0e6282d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0e4b7b823f58ecc87f112a3266ec31ccbb70d98994d5106b271c97386e6ed160e3bd86e6efa6dacc874b5b613dd2e9d26dc5a05abc22c226ea5d0f2d7931e59"} build_url:https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010942 build_url: 'https://queue.taskcluster.net/v1/task/Wr3_7NZYRnqm0nrurA6LGQ/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/39f48a26c3d9fc90a2ac3d93209d143170e831e29d1cb43a7f5e44cd851534154c4cc33558c44b80c32e39fada1b8efed74ae71397be8eafb515e54aca5d981e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e9c3d4bba06caeef6c7d7ea6c8374a32a0459f6531130b6bec6f84b9e224594c3cc0f142d3245143cbb272052481d3d6f0bf9409d1a484e92acb89a0e6282d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0e4b7b823f58ecc87f112a3266ec31ccbb70d98994d5106b271c97386e6ed160e3bd86e6efa6dacc874b5b613dd2e9d26dc5a05abc22c226ea5d0f2d7931e59"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 02:54:16.133922) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:54:16.134238) ========= 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.VH4Y4kKgyH/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.W5sCBz8jKS/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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.005176 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:54:16.182249) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 02:54:16.182552) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 02:54:16.182842) ========= ========= Total master_lag: 18.36 =========