builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1496177508.76 results: success (0) revision: fbe0e3f31233cc7846a2168c613452a1d7147cc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:48.762549) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:48.763120) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:48.763441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:48.796196) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:48.796551) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 13:51:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.2M=0s 2017-05-30 13:51:49 (69.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120054 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:48.933885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:48.934191) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015286 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:48.986597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:48.986920) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fbe0e3f31233cc7846a2168c613452a1d7147cc2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev fbe0e3f31233cc7846a2168c613452a1d7147cc2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 13:51:49,811 truncating revision to first 12 chars 2017-05-30 13:51:49,811 Setting DEBUG logging. 2017-05-30 13:51:49,811 attempt 1/10 2017-05-30 13:51:49,811 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fbe0e3f31233?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 13:51:50,427 unpacking tar archive at: mozilla-central-fbe0e3f31233/testing/mozharness/ program finished with exit code 0 elapsedTime=0.936001 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:49.937884) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:49.941206) ========= script_repo_revision: fbe0e3f31233cc7846a2168c613452a1d7147cc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:49.941574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:49.941834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 13:51:49.951471) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-30 13:51:49.951747) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:51:50 INFO - MultiFileLogger online at 20170530 13:51:50 in /builds/slave/test 13:51:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:51:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:51:50 INFO - {'append_to_log': False, 13:51:50 INFO - 'base_work_dir': '/builds/slave/test', 13:51:50 INFO - 'blob_upload_branch': 'Firefox', 13:51:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:51:50 INFO - 'branch': 'Firefox', 13:51:50 INFO - 'buildbot_json_path': 'buildprops.json', 13:51:50 INFO - 'config_files': ('talos/linux_config.py',), 13:51:50 INFO - 'default_actions': ('clobber', 13:51:50 INFO - 'read-buildbot-config', 13:51:50 INFO - 'download-and-extract', 13:51:50 INFO - 'populate-webroot', 13:51:50 INFO - 'create-virtualenv', 13:51:50 INFO - 'install', 13:51:50 INFO - 'setup-mitmproxy', 13:51:50 INFO - 'run-tests'), 13:51:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:51:50 INFO - 'download_minidump_stackwalk': True, 13:51:50 INFO - 'download_symbols': 'ondemand', 13:51:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:51:50 INFO - 'tooltool.py': '/tools/tooltool.py', 13:51:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:51:50 INFO - '/tools/misc-python/virtualenv.py')}, 13:51:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:51:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:51:50 INFO - 'gecko_profile': False, 13:51:50 INFO - 'gecko_profile_interval': 0, 13:51:50 INFO - 'installer_path': 'installer.exe', 13:51:50 INFO - 'log_level': 'info', 13:51:50 INFO - 'log_name': 'talos', 13:51:50 INFO - 'log_to_console': True, 13:51:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:51:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:51:50 INFO - 'opt_config_files': (), 13:51:50 INFO - 'pip_index': False, 13:51:50 INFO - 'suite': 'dromaeojs-e10s', 13:51:50 INFO - 'system_bits': '32', 13:51:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:51:50 INFO - 'title': 'talos-linux64-ix-022', 13:51:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:51:50 INFO - 'use_talos_json': True, 13:51:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:51:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:51:50 INFO - 'work_dir': 'build'} 13:51:50 INFO - [mozharness: 2017-05-30 20:51:50.865132Z] Running clobber step. 13:51:50 INFO - Running pre-action listener: _resource_record_pre_action 13:51:50 INFO - Running main action method: clobber 13:51:50 INFO - rmtree: /builds/slave/test/build 13:51:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:51:52 INFO - Running post-action listener: _resource_record_post_action 13:51:52 INFO - [mozharness: 2017-05-30 20:51:52.393530Z] Finished clobber step (success) 13:51:52 INFO - [mozharness: 2017-05-30 20:51:52.393631Z] Running read-buildbot-config step. 13:51:52 INFO - Running pre-action listener: _resource_record_pre_action 13:51:52 INFO - Running main action method: read_buildbot_config 13:51:52 INFO - Using buildbot properties: 13:51:52 INFO - { 13:51:52 INFO - "project": "", 13:51:52 INFO - "product": "firefox", 13:51:52 INFO - "who": "ryanvm@gmail.com", 13:51:52 INFO - "installer_path": "public/build/target.tar.bz2", 13:51:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 13:51:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 13:51:52 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 13:51:52 INFO - "stage_platform": "linux64-stylo", 13:51:52 INFO - "basedir": "/builds/slave/test", 13:51:52 INFO - "buildnumber": 130, 13:51:52 INFO - "platform": "ubuntu64_hw_stylo", 13:51:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:51:52 INFO - "slavebuilddir": "test", 13:51:52 INFO - "taskId": "b3gd04icQgycmvDb7Q9p6g", 13:51:52 INFO - "branch": "mozilla-central", 13:51:52 INFO - "script_repo_revision": "production", 13:51:52 INFO - "revision": "fbe0e3f31233cc7846a2168c613452a1d7147cc2", 13:51:52 INFO - "slavename": "talos-linux64-ix-022", 13:51:52 INFO - "repo_path": "mozilla-central" 13:51:52 INFO - } 13:51:52 INFO - Finding installer, test and symbols from parent task. 13:51:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b3gd04icQgycmvDb7Q9p6g'}, attempt #1 13:51:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b3gd04icQgycmvDb7Q9p6g'}, attempt #1 13:51:53 INFO - Task dependencies: Sgsv6Sb0TwSj4Up3Sb4Rwg 13:51:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg'}, attempt #1 13:51:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.tar.bz2 13:51:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/test_packages.json 13:51:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.crashreporter-symbols.zip 13:51:53 INFO - Running post-action listener: _resource_record_post_action 13:51:53 INFO - [mozharness: 2017-05-30 20:51:53.771644Z] Finished read-buildbot-config step (success) 13:51:53 INFO - [mozharness: 2017-05-30 20:51:53.771864Z] Running download-and-extract step. 13:51:53 INFO - Running pre-action listener: _resource_record_pre_action 13:51:53 INFO - Running main action method: download_and_extract 13:51:53 INFO - mkdir: /builds/slave/test/build/tests 13:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:51:53 INFO - trying https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.test_packages.json 13:51:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:51:54 INFO - Downloaded 986 bytes. 13:51:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:51:54 INFO - Using the following test package requirements: 13:51:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:51:54 INFO - u'common': [u'target.common.tests.zip'], 13:51:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:51:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:51:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:51:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:51:54 INFO - u'mozbase': [u'target.common.tests.zip'], 13:51:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:51:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:51:54 INFO - u'web-platform': [u'target.common.tests.zip', 13:51:54 INFO - u'target.web-platform.tests.zip'], 13:51:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:51:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:51:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.common.tests.zip 13:51:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:51:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.common.tests.zip into memory 13:51:55 INFO - Content-Length response header: 63527664 13:51:55 INFO - Bytes received: 63527664 13:52:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:52:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.common.tests.zip 13:52:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:52:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.common.tests.zip into memory 13:52:07 INFO - Content-Length response header: 63527664 13:52:07 INFO - Bytes received: 63527664 13:52:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.talos.tests.zip 13:52:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:52:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.talos.tests.zip into memory 13:52:21 INFO - Content-Length response header: 14447425 13:52:21 INFO - Bytes received: 14447425 13:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:22 INFO - trying https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.tar.bz2 13:52:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:52:23 INFO - Downloaded 55924200 bytes. 13:52:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.tar.bz2 13:52:23 INFO - mkdir: /builds/slave/test/properties 13:52:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:52:23 INFO - Writing to file /builds/slave/test/properties/build_url 13:52:23 INFO - Contents: 13:52:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.tar.bz2 13:52:23 INFO - Running post-action listener: _resource_record_post_action 13:52:23 INFO - Running post-action listener: set_extra_try_arguments 13:52:23 INFO - [mozharness: 2017-05-30 20:52:23.199898Z] Finished download-and-extract step (success) 13:52:23 INFO - [mozharness: 2017-05-30 20:52:23.199994Z] Running populate-webroot step. 13:52:23 INFO - Running pre-action listener: _resource_record_pre_action 13:52:23 INFO - Running main action method: populate_webroot 13:52:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:52:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:52:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:52:23 INFO - '--tppagecycles', 13:52:23 INFO - '7'], 13:52:23 INFO - 'tests': ['tsvgm']}}, 13:52:23 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:52:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:52:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:52:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:52:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:52:23 INFO - 'talos_options': ['--disable-e10s'], 13:52:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:52:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:52:23 INFO - 'talos_options': ['--disable-e10s'], 13:52:23 INFO - 'tests': ['damp', 'tps']}, 13:52:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:52:23 INFO - 'tests': ['damp', 'tps']}, 13:52:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:52:23 INFO - 'tests': ['dromaeo_dom']}, 13:52:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:52:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:52:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 13:52:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:52:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:52:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:52:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:52:23 INFO - 'tests': ['a11yr', 13:52:23 INFO - 'ts_paint', 13:52:23 INFO - 'tpaint', 13:52:23 INFO - 'sessionrestore', 13:52:23 INFO - 'sessionrestore_no_auto_restore', 13:52:23 INFO - 'tabpaint']}, 13:52:23 INFO - 'other-e10s': {'tests': ['a11yr', 13:52:23 INFO - 'ts_paint', 13:52:23 INFO - 'tpaint', 13:52:23 INFO - 'sessionrestore', 13:52:23 INFO - 'sessionrestore_no_auto_restore', 13:52:23 INFO - 'tabpaint']}, 13:52:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:52:23 INFO - 'ts_paint', 13:52:23 INFO - 'tpaint', 13:52:23 INFO - 'sessionrestore', 13:52:23 INFO - 'sessionrestore_no_auto_restore', 13:52:23 INFO - 'tabpaint']}, 13:52:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:52:23 INFO - 'ts_paint', 13:52:23 INFO - 'tpaint', 13:52:23 INFO - 'sessionrestore', 13:52:23 INFO - 'sessionrestore_no_auto_restore', 13:52:23 INFO - 'tabpaint']}, 13:52:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:52:23 INFO - 'tests': ['a11yr', 13:52:23 INFO - 'ts_paint', 13:52:23 INFO - 'tpaint', 13:52:23 INFO - 'sessionrestore', 13:52:23 INFO - 'sessionrestore_no_auto_restore', 13:52:23 INFO - 'tabpaint']}, 13:52:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:52:23 INFO - 'tests': ['a11yr', 13:52:23 INFO - 'ts_paint', 13:52:23 INFO - 'tpaint', 13:52:23 INFO - 'sessionrestore', 13:52:23 INFO - 'sessionrestore_no_auto_restore', 13:52:23 INFO - 'tabpaint']}, 13:52:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 13:52:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 13:52:23 INFO - 'bloom_basic_ref']}, 13:52:23 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 13:52:23 INFO - 'talos_options': ['--mitmproxy', 13:52:23 INFO - 'mitmproxy-recording-1.mp', 13:52:23 INFO - '--firstNonBlankPaint'], 13:52:23 INFO - 'tests': ['Quantum_1']}, 13:52:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:52:23 INFO - 'tests': ['tsvgx', 13:52:23 INFO - 'tsvgr_opacity', 13:52:23 INFO - 'tart', 13:52:23 INFO - 'tscrollx', 13:52:23 INFO - 'cart', 13:52:23 INFO - 'tsvg_static']}, 13:52:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:52:23 INFO - 'tsvgr_opacity', 13:52:23 INFO - 'tart', 13:52:23 INFO - 'tscrollx', 13:52:23 INFO - 'cart', 13:52:23 INFO - 'tsvg_static']}, 13:52:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:52:23 INFO - 'talos_options': ['--disable-e10s'], 13:52:23 INFO - 'tests': ['tp5o']}, 13:52:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:52:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:52:23 INFO - 'talos_options': ['--disable-e10s', 13:52:23 INFO - '--xperf_path', 13:52:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:23 INFO - 'tests': ['tp5n']}, 13:52:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:52:23 INFO - 'talos_options': ['--xperf_path', 13:52:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:23 INFO - 'tests': ['tp5n']}}, 13:52:23 INFO - 'talos.zip': {'path': '', 13:52:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:52:23 INFO - Running post-action listener: _resource_record_post_action 13:52:23 INFO - [mozharness: 2017-05-30 20:52:23.214351Z] Finished populate-webroot step (success) 13:52:23 INFO - [mozharness: 2017-05-30 20:52:23.214446Z] Running create-virtualenv step. 13:52:23 INFO - Running pre-action listener: _resource_record_pre_action 13:52:23 INFO - Running main action method: create_virtualenv 13:52:23 INFO - Creating virtualenv /builds/slave/test/build/venv 13:52:23 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 13:52:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:52:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:52:23 INFO - Using real prefix '/usr' 13:52:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:52:23 INFO - Installing distribute.............................................................................................................................................................................................done. 13:52:25 INFO - Installing pip.................done. 13:52:25 INFO - Return code: 0 13:52:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:52:26 INFO - Reading from file tmpfile_stdout 13:52:26 INFO - Output received: 13:52:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:52:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:26 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/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 0x12e43b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165ee40>, '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 0x165ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1660440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 13:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:52:26 INFO - Using env: {'DISPLAY': ':0', 13:52:26 INFO - 'HOME': '/home/cltbld', 13:52:26 INFO - 'LANG': 'en_US.UTF-8', 13:52:26 INFO - 'LANGUAGE': 'en_US:en', 13:52:26 INFO - 'LOGNAME': 'cltbld', 13:52:26 INFO - 'MAIL': '/var/mail/cltbld', 13:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:26 INFO - 'MOZ_NO_REMOTE': '1', 13:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:26 INFO - 'NO_EM_RESTART': '1', 13:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:26 INFO - 'PWD': '/builds/slave/test', 13:52:26 INFO - 'SHELL': '/bin/bash', 13:52:26 INFO - 'SHLVL': '1', 13:52:26 INFO - 'TERM': 'linux', 13:52:26 INFO - 'TMOUT': '86400', 13:52:26 INFO - 'USER': 'cltbld', 13:52:26 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 13:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:26 INFO - '_': '/tools/buildbot/bin/python'} 13:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:26 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 13:52:26 INFO - Cleaning up... 13:52:26 INFO - Return code: 0 13:52:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:26 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/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 0x12e43b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165ee40>, '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 0x165ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1660440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 13:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:52:26 INFO - Using env: {'DISPLAY': ':0', 13:52:26 INFO - 'HOME': '/home/cltbld', 13:52:26 INFO - 'LANG': 'en_US.UTF-8', 13:52:26 INFO - 'LANGUAGE': 'en_US:en', 13:52:26 INFO - 'LOGNAME': 'cltbld', 13:52:26 INFO - 'MAIL': '/var/mail/cltbld', 13:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:26 INFO - 'MOZ_NO_REMOTE': '1', 13:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:26 INFO - 'NO_EM_RESTART': '1', 13:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:26 INFO - 'PWD': '/builds/slave/test', 13:52:26 INFO - 'SHELL': '/bin/bash', 13:52:26 INFO - 'SHLVL': '1', 13:52:26 INFO - 'TERM': 'linux', 13:52:26 INFO - 'TMOUT': '86400', 13:52:26 INFO - 'USER': 'cltbld', 13:52:26 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 13:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:26 INFO - '_': '/tools/buildbot/bin/python'} 13:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:26 INFO - Downloading/unpacking psutil>=3.1.1 13:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:52:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:27 INFO - Installing collected packages: psutil 13:52:27 INFO - Running setup.py install for psutil 13:52:27 INFO - building 'psutil._psutil_linux' extension 13:52:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:52:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:52:27 INFO - building 'psutil._psutil_posix' extension 13:52:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:52:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:52:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:28 INFO - Successfully installed psutil 13:52:28 INFO - Cleaning up... 13:52:28 INFO - Return code: 0 13:52:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:28 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/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 0x12e43b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165ee40>, '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 0x165ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1660440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 13:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:52:28 INFO - Using env: {'DISPLAY': ':0', 13:52:28 INFO - 'HOME': '/home/cltbld', 13:52:28 INFO - 'LANG': 'en_US.UTF-8', 13:52:28 INFO - 'LANGUAGE': 'en_US:en', 13:52:28 INFO - 'LOGNAME': 'cltbld', 13:52:28 INFO - 'MAIL': '/var/mail/cltbld', 13:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:28 INFO - 'MOZ_NO_REMOTE': '1', 13:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:28 INFO - 'NO_EM_RESTART': '1', 13:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:28 INFO - 'PWD': '/builds/slave/test', 13:52:28 INFO - 'SHELL': '/bin/bash', 13:52:28 INFO - 'SHLVL': '1', 13:52:28 INFO - 'TERM': 'linux', 13:52:28 INFO - 'TMOUT': '86400', 13:52:28 INFO - 'USER': 'cltbld', 13:52:28 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 13:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:28 INFO - '_': '/tools/buildbot/bin/python'} 13:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:52:29 INFO - Installing collected packages: mozsystemmonitor 13:52:29 INFO - Running setup.py install for mozsystemmonitor 13:52:29 INFO - Successfully installed mozsystemmonitor 13:52:29 INFO - Cleaning up... 13:52:29 INFO - Return code: 0 13:52:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:29 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/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 0x12e43b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165ee40>, '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 0x165ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1660440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 13:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:52:29 INFO - Using env: {'DISPLAY': ':0', 13:52:29 INFO - 'HOME': '/home/cltbld', 13:52:29 INFO - 'LANG': 'en_US.UTF-8', 13:52:29 INFO - 'LANGUAGE': 'en_US:en', 13:52:29 INFO - 'LOGNAME': 'cltbld', 13:52:29 INFO - 'MAIL': '/var/mail/cltbld', 13:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:29 INFO - 'MOZ_NO_REMOTE': '1', 13:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:29 INFO - 'NO_EM_RESTART': '1', 13:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:29 INFO - 'PWD': '/builds/slave/test', 13:52:29 INFO - 'SHELL': '/bin/bash', 13:52:29 INFO - 'SHLVL': '1', 13:52:29 INFO - 'TERM': 'linux', 13:52:29 INFO - 'TMOUT': '86400', 13:52:29 INFO - 'USER': 'cltbld', 13:52:29 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 13:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:29 INFO - '_': '/tools/buildbot/bin/python'} 13:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:29 INFO - Downloading/unpacking jsonschema==2.5.1 13:52:29 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 13:52:29 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 13:52:29 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 13:52:29 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 13:52:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:52:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:52: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 13:52: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 13:52: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 13:52: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 13:52:31 INFO - Downloading functools32-3.2.3-2.tar.gz 13:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:52:31 INFO - warning: no files found matching '*.txt' 13:52:31 INFO - no previously-included directories found matching 'build' 13:52:31 INFO - no previously-included directories found matching 'dist' 13:52:31 INFO - no previously-included directories found matching '.git*' 13:52:31 INFO - Installing collected packages: jsonschema, functools32 13:52:31 INFO - Running setup.py install for functools32 13:52:31 INFO - warning: no files found matching '*.txt' 13:52:31 INFO - no previously-included directories found matching 'build' 13:52:31 INFO - no previously-included directories found matching 'dist' 13:52:31 INFO - no previously-included directories found matching '.git*' 13:52:31 INFO - Successfully installed jsonschema functools32 13:52:31 INFO - Cleaning up... 13:52:31 INFO - Return code: 0 13:52:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52: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/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 0x12e43b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165ee40>, '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 0x165ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1660440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 13:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:52:31 INFO - Using env: {'DISPLAY': ':0', 13:52:31 INFO - 'HOME': '/home/cltbld', 13:52:31 INFO - 'LANG': 'en_US.UTF-8', 13:52:31 INFO - 'LANGUAGE': 'en_US:en', 13:52:31 INFO - 'LOGNAME': 'cltbld', 13:52:31 INFO - 'MAIL': '/var/mail/cltbld', 13:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:31 INFO - 'MOZ_NO_REMOTE': '1', 13:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:31 INFO - 'NO_EM_RESTART': '1', 13:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:31 INFO - 'PWD': '/builds/slave/test', 13:52:31 INFO - 'SHELL': '/bin/bash', 13:52:31 INFO - 'SHLVL': '1', 13:52:31 INFO - 'TERM': 'linux', 13:52:31 INFO - 'TMOUT': '86400', 13:52:31 INFO - 'USER': 'cltbld', 13:52:31 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 13:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:31 INFO - '_': '/tools/buildbot/bin/python'} 13:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:52:31 INFO - Cleaning up... 13:52:31 INFO - Return code: 0 13:52:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52: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/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 0x12e43b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165ee40>, '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 0x165ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1660440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 13:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:52:31 INFO - Using env: {'DISPLAY': ':0', 13:52:31 INFO - 'HOME': '/home/cltbld', 13:52:31 INFO - 'LANG': 'en_US.UTF-8', 13:52:31 INFO - 'LANGUAGE': 'en_US:en', 13:52:31 INFO - 'LOGNAME': 'cltbld', 13:52:31 INFO - 'MAIL': '/var/mail/cltbld', 13:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:31 INFO - 'MOZ_NO_REMOTE': '1', 13:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:31 INFO - 'NO_EM_RESTART': '1', 13:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:31 INFO - 'PWD': '/builds/slave/test', 13:52:31 INFO - 'SHELL': '/bin/bash', 13:52:31 INFO - 'SHLVL': '1', 13:52:31 INFO - 'TERM': 'linux', 13:52:31 INFO - 'TMOUT': '86400', 13:52:31 INFO - 'USER': 'cltbld', 13:52:31 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 13:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:31 INFO - '_': '/tools/buildbot/bin/python'} 13:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:31 INFO - Downloading/unpacking blobuploader==1.2.4 13:52: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 13:52: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 13:52: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 13:52: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 13:52:32 INFO - Downloading blobuploader-1.2.4.tar.gz 13:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:52:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:52:32 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 13:52:32 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 13:52:32 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 13:52:32 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 13:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:52:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:52:33 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 13:52:33 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 13:52:33 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 13:52:33 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 13:52:33 INFO - Downloading docopt-0.6.1.tar.gz 13:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:52:33 INFO - Installing collected packages: blobuploader, requests, docopt 13:52:33 INFO - Running setup.py install for blobuploader 13:52:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:52:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:52:33 INFO - Running setup.py install for requests 13:52:33 INFO - Running setup.py install for docopt 13:52:34 INFO - Successfully installed blobuploader requests docopt 13:52:34 INFO - Cleaning up... 13:52:34 INFO - Return code: 0 13:52:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:34 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/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 0x12e43b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165ee40>, '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 0x165ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1660440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:34 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:52:34 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:52:34 INFO - Using env: {'DISPLAY': ':0', 13:52:34 INFO - 'HOME': '/home/cltbld', 13:52:34 INFO - 'LANG': 'en_US.UTF-8', 13:52:34 INFO - 'LANGUAGE': 'en_US:en', 13:52:34 INFO - 'LOGNAME': 'cltbld', 13:52:34 INFO - 'MAIL': '/var/mail/cltbld', 13:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:34 INFO - 'MOZ_NO_REMOTE': '1', 13:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:34 INFO - 'NO_EM_RESTART': '1', 13:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:34 INFO - 'PWD': '/builds/slave/test', 13:52:34 INFO - 'SHELL': '/bin/bash', 13:52:34 INFO - 'SHLVL': '1', 13:52:34 INFO - 'TERM': 'linux', 13:52:34 INFO - 'TMOUT': '86400', 13:52:34 INFO - 'USER': 'cltbld', 13:52:34 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 13:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:34 INFO - '_': '/tools/buildbot/bin/python'} 13:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:52:34 INFO - Running setup.py (path:/tmp/pip-baDdpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:52:34 INFO - Running setup.py (path:/tmp/pip-fwu3fX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:52:34 INFO - Running setup.py (path:/tmp/pip-xU8qHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:52:34 INFO - Running setup.py (path:/tmp/pip-Lsho9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:52:34 INFO - Running setup.py (path:/tmp/pip-Sb6GIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:52:34 INFO - Running setup.py (path:/tmp/pip-T7qFwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:52:34 INFO - Running setup.py (path:/tmp/pip-0XKNkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:52:34 INFO - Running setup.py (path:/tmp/pip-faaojv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:52:34 INFO - Running setup.py (path:/tmp/pip-zL9AdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:52:34 INFO - Running setup.py (path:/tmp/pip-5aYhPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:52:35 INFO - Running setup.py (path:/tmp/pip-jZ31dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:52:35 INFO - Running setup.py (path:/tmp/pip-ynGCgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:52:35 INFO - Running setup.py (path:/tmp/pip-FZGO16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:52:35 INFO - Running setup.py (path:/tmp/pip-D2tj54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:35 INFO - Running setup.py (path:/tmp/pip-KQ7tmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:52:35 INFO - Running setup.py (path:/tmp/pip-qzkP1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:52:35 INFO - Running setup.py (path:/tmp/pip-Pp5VVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:52:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:52:35 INFO - Running setup.py install for manifestparser 13:52:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:52:35 INFO - Running setup.py install for mozcrash 13:52:35 INFO - Running setup.py install for mozdebug 13:52:35 INFO - Running setup.py install for mozdevice 13:52:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:52:35 INFO - Running setup.py install for mozfile 13:52:36 INFO - Running setup.py install for mozhttpd 13:52:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:52:36 INFO - Running setup.py install for mozinfo 13:52:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:52:36 INFO - Running setup.py install for mozInstall 13:52:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:52:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:52:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:52:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:52:36 INFO - Running setup.py install for mozleak 13:52:36 INFO - Running setup.py install for mozlog 13:52:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:52:36 INFO - Running setup.py install for moznetwork 13:52:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:52:36 INFO - Running setup.py install for mozprocess 13:52:36 INFO - Running setup.py install for mozprofile 13:52:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:52:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:52:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:52:36 INFO - Running setup.py install for mozrunner 13:52:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:52:37 INFO - Running setup.py install for mozscreenshot 13:52:37 INFO - Running setup.py install for moztest 13:52:37 INFO - Running setup.py install for mozversion 13:52:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:52:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:52:37 INFO - Cleaning up... 13:52:37 INFO - Return code: 0 13:52:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:37 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/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 0x12e43b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165ee40>, '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 0x165ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1660440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:37 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:52:37 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:52:37 INFO - Using env: {'DISPLAY': ':0', 13:52:37 INFO - 'HOME': '/home/cltbld', 13:52:37 INFO - 'LANG': 'en_US.UTF-8', 13:52:37 INFO - 'LANGUAGE': 'en_US:en', 13:52:37 INFO - 'LOGNAME': 'cltbld', 13:52:37 INFO - 'MAIL': '/var/mail/cltbld', 13:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:37 INFO - 'MOZ_NO_REMOTE': '1', 13:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:37 INFO - 'NO_EM_RESTART': '1', 13:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:37 INFO - 'PWD': '/builds/slave/test', 13:52:37 INFO - 'SHELL': '/bin/bash', 13:52:37 INFO - 'SHLVL': '1', 13:52:37 INFO - 'TERM': 'linux', 13:52:37 INFO - 'TMOUT': '86400', 13:52:37 INFO - 'USER': 'cltbld', 13:52:37 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 13:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:37 INFO - '_': '/tools/buildbot/bin/python'} 13:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:52:37 INFO - Running setup.py (path:/tmp/pip-iIOKsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:52:37 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)) 13:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:52:37 INFO - Running setup.py (path:/tmp/pip-WvQ6Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:52:37 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)) 13:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:52:37 INFO - Running setup.py (path:/tmp/pip-BYgqt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:52:37 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)) 13:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:52:37 INFO - Running setup.py (path:/tmp/pip-j5J3oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 13:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:52:37 INFO - Running setup.py (path:/tmp/pip-jbgXC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:52:37 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)) 13:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:52:37 INFO - Running setup.py (path:/tmp/pip-ifVhPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:52:37 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)) 13:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:52:37 INFO - Running setup.py (path:/tmp/pip-Uk9zvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:52:38 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)) 13:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:52:38 INFO - Running setup.py (path:/tmp/pip-6Rebm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:52:38 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)) 13:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:52:38 INFO - Running setup.py (path:/tmp/pip-V8vDcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:52:38 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)) 13:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:52:38 INFO - Running setup.py (path:/tmp/pip-sc4VR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:52:38 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)) 13:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:52:38 INFO - Running setup.py (path:/tmp/pip-g8rxbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:52:38 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)) 13:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:52:38 INFO - Running setup.py (path:/tmp/pip-reqJSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:52:38 INFO - Running setup.py (path:/tmp/pip-3zV7bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:52:38 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)) 13:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:52:38 INFO - Running setup.py (path:/tmp/pip-HDIQz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:52:38 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)) 13:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:38 INFO - Running setup.py (path:/tmp/pip-n1k0_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:38 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)) 13:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:52:38 INFO - Running setup.py (path:/tmp/pip-KOlEIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:52:38 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)) 13:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:52:38 INFO - Running setup.py (path:/tmp/pip-i30zKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:52:38 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)) 13:52:38 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)) 13:52:38 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)) 13:52:38 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)) 13:52:38 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:52:38 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:52:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:39 INFO - Downloading blessings-1.6.tar.gz 13:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:52:39 INFO - Installing collected packages: blessings 13:52:39 INFO - Running setup.py install for blessings 13:52:40 INFO - Successfully installed blessings 13:52:40 INFO - Cleaning up... 13:52:40 INFO - Return code: 0 13:52:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:52:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:52:40 INFO - Reading from file tmpfile_stdout 13:52:40 INFO - Current package versions: 13:52:40 INFO - argparse == 1.2.1 13:52:40 INFO - blessings == 1.6 13:52:40 INFO - blobuploader == 1.2.4 13:52:40 INFO - docopt == 0.6.1 13:52:40 INFO - functools32 == 3.2.3-2 13:52:40 INFO - jsonschema == 2.5.1 13:52:40 INFO - manifestparser == 1.1 13:52:40 INFO - mozInstall == 1.12 13:52:40 INFO - mozcrash == 1.0 13:52:40 INFO - mozdebug == 0.1 13:52:40 INFO - mozdevice == 0.51 13:52:40 INFO - mozfile == 1.2 13:52:40 INFO - mozhttpd == 0.7 13:52:40 INFO - mozinfo == 0.9 13:52:40 INFO - mozleak == 0.1 13:52:40 INFO - mozlog == 3.4 13:52:40 INFO - moznetwork == 0.27 13:52:40 INFO - mozprocess == 0.25 13:52:40 INFO - mozprofile == 0.28 13:52:40 INFO - mozrunner == 6.13 13:52:40 INFO - mozscreenshot == 0.1 13:52:40 INFO - mozsystemmonitor == 0.3 13:52:40 INFO - moztest == 0.8 13:52:40 INFO - mozversion == 1.4 13:52:40 INFO - psutil == 3.1.1 13:52:40 INFO - requests == 1.2.3 13:52:40 INFO - wsgiref == 0.1.2 13:52:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:40 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/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 0x12e43b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165ee40>, '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 0x165ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1660440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:40 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:52:40 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:52:40 INFO - Using env: {'DISPLAY': ':0', 13:52:40 INFO - 'HOME': '/home/cltbld', 13:52:40 INFO - 'LANG': 'en_US.UTF-8', 13:52:40 INFO - 'LANGUAGE': 'en_US:en', 13:52:40 INFO - 'LOGNAME': 'cltbld', 13:52:40 INFO - 'MAIL': '/var/mail/cltbld', 13:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:40 INFO - 'MOZ_NO_REMOTE': '1', 13:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:40 INFO - 'NO_EM_RESTART': '1', 13:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:40 INFO - 'PWD': '/builds/slave/test', 13:52:40 INFO - 'SHELL': '/bin/bash', 13:52:40 INFO - 'SHLVL': '1', 13:52:40 INFO - 'TERM': 'linux', 13:52:40 INFO - 'TMOUT': '86400', 13:52:40 INFO - 'USER': 'cltbld', 13:52:40 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 13:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:40 INFO - '_': '/tools/buildbot/bin/python'} 13:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:40 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)) 13:52:40 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)) 13:52:40 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)) 13:52:40 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)) 13:52:40 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)) 13:52:40 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)) 13:52:40 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)) 13:52:40 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)) 13:52:40 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)) 13:52:40 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:52: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 13:52: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 13:52: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 13:52: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 13:52:41 INFO - Downloading marionette_driver-1.4.0.tar.gz 13:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 13:52:41 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)) 13:52:41 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)) 13:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:52:41 INFO - Installing collected packages: marionette-driver 13:52:41 INFO - Running setup.py install for marionette-driver 13:52:41 INFO - Successfully installed marionette-driver 13:52:41 INFO - Cleaning up... 13:52:41 INFO - Return code: 0 13:52:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:41 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/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 0x12e43b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165ee40>, '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 0x165ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1660440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:52:41 INFO - Using env: {'DISPLAY': ':0', 13:52:41 INFO - 'HOME': '/home/cltbld', 13:52:41 INFO - 'LANG': 'en_US.UTF-8', 13:52:41 INFO - 'LANGUAGE': 'en_US:en', 13:52:41 INFO - 'LOGNAME': 'cltbld', 13:52:41 INFO - 'MAIL': '/var/mail/cltbld', 13:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:41 INFO - 'MOZ_NO_REMOTE': '1', 13:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:41 INFO - 'NO_EM_RESTART': '1', 13:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:41 INFO - 'PWD': '/builds/slave/test', 13:52:41 INFO - 'SHELL': '/bin/bash', 13:52:41 INFO - 'SHLVL': '1', 13:52:41 INFO - 'TERM': 'linux', 13:52:41 INFO - 'TMOUT': '86400', 13:52:41 INFO - 'USER': 'cltbld', 13:52:41 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 13:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:41 INFO - '_': '/tools/buildbot/bin/python'} 13:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:52:42 INFO - Cleaning up... 13:52:42 INFO - Return code: 0 13:52:42 INFO - Running post-action listener: _resource_record_post_action 13:52:42 INFO - Running post-action listener: _start_resource_monitoring 13:52:42 INFO - Starting resource monitoring. 13:52:42 INFO - [mozharness: 2017-05-30 20:52:42.114624Z] Finished create-virtualenv step (success) 13:52:42 INFO - [mozharness: 2017-05-30 20:52:42.115097Z] Running install step. 13:52:42 INFO - Running pre-action listener: _resource_record_pre_action 13:52:42 INFO - Running main action method: install 13:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:52:42 INFO - Reading from file tmpfile_stdout 13:52:42 INFO - Detecting whether we're running mozinstall >=1.0... 13:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:52:42 INFO - Reading from file tmpfile_stdout 13:52:42 INFO - Output received: 13:52:42 INFO - Usage: mozinstall [options] installer 13:52:42 INFO - Options: 13:52:42 INFO - -h, --help show this help message and exit 13:52:42 INFO - -d DEST, --destination=DEST 13:52:42 INFO - Directory to install application into. [default: 13:52:42 INFO - "/builds/slave/test"] 13:52:42 INFO - --app=APP Application being installed. [default: firefox] 13:52:42 INFO - mkdir: /builds/slave/test/build/application 13:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:52:58 INFO - Reading from file tmpfile_stdout 13:52:58 INFO - Output received: 13:52:58 INFO - /builds/slave/test/build/application/firefox/firefox 13:52:58 INFO - Running post-action listener: _resource_record_post_action 13:52:58 INFO - [mozharness: 2017-05-30 20:52:58.479213Z] Finished install step (success) 13:52:58 INFO - [mozharness: 2017-05-30 20:52:58.479493Z] Running setup-mitmproxy step. 13:52:58 INFO - Running pre-action listener: _resource_record_pre_action 13:52:58 INFO - Running main action method: setup_mitmproxy 13:52:58 INFO - Skipping: mitmproxy is not required 13:52:58 INFO - Running post-action listener: _resource_record_post_action 13:52:58 INFO - [mozharness: 2017-05-30 20:52:58.480705Z] Finished setup-mitmproxy step (success) 13:52:58 INFO - [mozharness: 2017-05-30 20:52:58.480925Z] Running run-tests step. 13:52:58 INFO - Running pre-action listener: _resource_record_pre_action 13:52:58 INFO - Running main action method: run_tests 13:52:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:52:58 INFO - Python 2.7.3 13:52:58 INFO - Return code: 0 13:52:58 INFO - grabbing minidump binary from tooltool 13:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 13:52:58 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/linux64/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 0x165ee40>, '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 0x165ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1660440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:52:58 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:52:58 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/linux64/releng.manifest -o -c /builds/tooltool_cache 13:52:58 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:52:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:52:58 INFO - Return code: 0 13:52:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:52:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:52:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:52:58 INFO - ENV: RUST_BACKTRACE is now 1 13:52:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:52:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:52:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 13:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 13:52:58 INFO - Using env: {'DISPLAY': ':0', 13:52:58 INFO - 'HOME': '/home/cltbld', 13:52:58 INFO - 'LANG': 'en_US.UTF-8', 13:52:58 INFO - 'LANGUAGE': 'en_US:en', 13:52:58 INFO - 'LOGNAME': 'cltbld', 13:52:58 INFO - 'MAIL': '/var/mail/cltbld', 13:52:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:58 INFO - 'MOZ_NO_REMOTE': '1', 13:52:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:58 INFO - 'NO_EM_RESTART': '1', 13:52:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:58 INFO - 'PWD': '/builds/slave/test', 13:52:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:58 INFO - 'RUST_BACKTRACE': '1', 13:52:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:52:58 INFO - 'SHELL': '/bin/bash', 13:52:58 INFO - 'SHLVL': '1', 13:52:58 INFO - 'TERM': 'linux', 13:52:58 INFO - 'TMOUT': '86400', 13:52:58 INFO - 'USER': 'cltbld', 13:52:58 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248', 13:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:58 INFO - '_': '/tools/buildbot/bin/python'} 13:52:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 13:52:58 INFO - mozversion application_buildid: 20170530200920 13:52:58 INFO - mozversion application_changeset: fbe0e3f31233cc7846a2168c613452a1d7147cc2 13:52:58 INFO - mozversion application_display_name: Nightly 13:52:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:52:58 INFO - mozversion application_name: Firefox 13:52:58 INFO - mozversion application_remotingname: firefox 13:52:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:52:58 INFO - mozversion application_vendor: Mozilla 13:52:58 INFO - mozversion application_version: 55.0a1 13:52:58 INFO - mozversion platform_buildid: 20170530200920 13:52:58 INFO - mozversion platform_changeset: fbe0e3f31233cc7846a2168c613452a1d7147cc2 13:52:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:52:58 INFO - mozversion platform_version: 55.0a1 13:52:58 INFO - using testdate: 1496177578 13:52:58 INFO - actual date: 1496177578 13:52:58 INFO - starting webserver on 'localhost:34077' 13:52:58 INFO - SUITE-START | Running 2 tests 13:52:58 INFO - TEST-START | dromaeo_css 13:52:58 INFO - operating with platform_type : linux_ 13:52:58 INFO - Initialising browser for dromaeo_css test... 13:52:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34077/getInfo.html -profile /tmp/tmpybVi2V/profile 13:52:58 INFO - TEST-INFO | started process 27486 (/builds/slave/test/build/application/firefox/firefox http://localhost:34077/getInfo.html) 13:53:34 INFO - TEST-INFO | 27486: killed by SIGTERM 13:53:34 INFO - Browser initialized. 13:53:34 INFO - Running cycle 1/1 for dromaeo_css test... 13:53:34 INFO - TEST-INFO | started process 27709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpybVi2V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:46 INFO - PID 27709 | RSS: Main: 186134528 13:53:46 INFO - PID 27709 | 13:56:51 INFO - PID 27709 | Cycle 1(1): loaded http://localhost:34077/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34077/tests/dromaeo/cssquery-ext.html) 13:56:53 INFO - PID 27709 | RSS: Main: 183848960 13:56:53 INFO - PID 27709 | 13:59:55 INFO - PID 27709 | Cycle 1(1): loaded http://localhost:34077/tests/dromaeo/cssquery-ext.html (next: http://localhost:34077/tests/dromaeo/cssquery-jquery.html) 13:59:55 INFO - PID 27709 | RSS: Main: 186847232 13:59:55 INFO - PID 27709 | 14:02:57 INFO - PID 27709 | Cycle 1(1): loaded http://localhost:34077/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34077/tests/dromaeo/cssquery-mootools.html) 14:02:58 INFO - PID 27709 | RSS: Main: 184795136 14:02:58 INFO - PID 27709 | 14:06:00 INFO - PID 27709 | Cycle 1(1): loaded http://localhost:34077/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34077/tests/dromaeo/cssquery-prototype.html) 14:06:00 INFO - PID 27709 | RSS: Main: 190070784 14:06:00 INFO - PID 27709 | 14:09:03 INFO - PID 27709 | Cycle 1(1): loaded http://localhost:34077/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34077/tests/dromaeo/cssquery-yui.html) 14:09:04 INFO - PID 27709 | RSS: Main: 187457536 14:09:04 INFO - PID 27709 | 14:12:06 INFO - PID 27709 | Cycle 1(1): loaded http://localhost:34077/tests/dromaeo/cssquery-yui.html (next: http://localhost:34077/tests/dromaeo/cssquery-dojo.html) 14:12:06 INFO - PID 27709 | RSS: Main: 185122816 14:12:06 INFO - PID 27709 | 14:12:06 INFO - PID 27709 | __start_tp_report 14:12:06 INFO - PID 27709 | _x_x_mozilla_page_load 14:12:06 INFO - PID 27709 | _x_x_mozilla_page_load_details 14:12:06 INFO - PID 27709 | |i|pagename|runs| 14:12:06 INFO - PID 27709 | |0;dojo.html;2754.8622568871556;2776.472470230657;2800.6919238883734;2808.129479861243;2813.5217013107763;5213.86965325867;5284.445133261005;5321.7073060981675;5324.520793128618;5331.520163185312;5216.113260745673;5275.129603615399;5296.894062118756;5318.2554442378005;5354.14333706607;4736.644751643623;4746.382970213867;4772.04559088182;4788.928166077511;4815.446223684268;4621.2837010263465;4788.736619485927;4827.903441931159;4832.275158726184;4855.126077306083;4621.4685311189305;4692;4757;4810.615150787964;4812.254100614393;4601.700889442175;4764.142454358214;4771.856844294677;4784.952150478485;4797.880052998668;4719.315699223594;4731.787069581843;4733.905321893577;4742.857714268577;4756.9286460703115;5237.319148510707;5321.467853214686;5334.279872217278;5339.866503337409;5358.490943360413;5666.036773748473;5785.334686511063;5804.071348584249;5810.796622118206;5819.82540523785;5714.914166308429;5716.256886604757;5722.713864306768;5728.054870946289;5780.739866706008;5346.893062138735;5351.09031464652;5352.759125839347;5369.892602147975;5409.486098820606;5694.743736531866;5775.5090817281;5777.7977770777825;5854.121881717691;5961.344252132262;5583.078791999355;5662.603617746719;5671.773129074873;5689.2319536862;5696.145578163226;5644.74598643062;5656;5667.518260947865;5686.0333743263745;5750.2237197978575;5525.254090697785;5553.722313884289;5599.888002239933;5722.141678748221;5726.828195154068;5673.092305231144;5713.171590119493;5755.827325180251;5762.394948530344;5799.6230245034785;4807.351007613997;4826.927596086061;4848.0788650156355;4866.8053277868485;4875.024995001014;4096.139810639739;4117.835286588563;4125.834966601363;4139.379093136054;4170.124273902515;4735.502772208937;4750.904981900343;4755.667103302736;4846.030793841246;4847.975760121177;5781.017227071408;5784.971075144597;5793.24687790593;5794.246747922827;5843.415658434123;4823.614110871122;4827.565519103297;4827.927581086286;4831.589314908202;4858.514148585114;4939.456659767423;5008.599312055099;5119.462456442095;5120.513551212629;5123.231515272664;5280.260763493037;5331.067063263991;5338.3060202173465;5353.785848566014;5372.435894231206;5618.129189975561;5666.744996475086;5685.744141513559;5706.9727449059565;5755;5219.373675158853;5251.317328747238;5303.867403314794;5336.852576696029;5344.064788662046;5664.405237450009;5665.263515742927;5682.602217844877;5690.573207009574;5700;5712.65724056558;5749;5790.392008839011;5800.100984347433;5801.564882633904;5529.668219906818;5567.081431563746;5582.246396736388;5607.579431542569;5618.550515958796;5548.361938377138;5557.3331200256225;5558.44415558441;5559.58303127259;5572.080606699849;5438.265834112344;5470.835874923759;5484.314460692413;5516.393196748274;5524.392316845064;5580.330360356783;5644.491995720405;5673.74468148926;5676.347220069745;5686.033374326292;5463.344398672026;5469.042917489503;5474.671519708831;5493.615446918837;5519.806806761905 14:12:06 INFO - PID 27709 | |1;ext.html;605.4339192854678;673.0644404278054;679.6499802601661;1078.6170909327188;1085.9728506787335;30006.399872002574;30501.542476862836;30552.847235763846;30612.08163755091;30621.69378306216;29227.123186304445;29574.824405728967;29624.703752962465;29670;29670.10989670308;6192.040233763774;6430.421262086411;6644.501662375317;6649.634270115142;6671.933280667204;6667.899981500282;6772.424343930772;6780.321967803229;6789.049533065375;6796.2863899290605;6748.4938629602975;6756.797296081101;6818.488613353993;6822.454203663719;6824.488163387741;6665.400113989765;6728.125343705336;6738.865222695567;6778.5593936394225;6804.795856124275;6549.443297319734;6562.573432726857;6574.506911981573;6608.504362172856;6637.502187335969;28869.855650721824;28883.711162888314;29071.41857162845;29126.70873291261;29173;2673.064427450396;2673.639058727066;2690.8385496870055;2698.649175607178;2704.3779930615874;22133.778662213495;22359.217427390126;22438.88780556103;22493.32520024402;22530.887345563333;3007.5639032340187;3018.1247438242885;3022.0480548627334;3035.3777475617444;3050.23744063984;131654.3417282917;131860;132320.3383983074;154495;158658;34197.65802341994;34207.65792342094;34315;34387.31225375478;34416.48375274373;35819.104522386624;35836;35846.1038474035;35942.86657034475;36044;10833.079188269085;10921.508532116073;10922.726931826768;10925.399103049249;10987.670369888916;8746.431481953652;8758.386912916034;8759.518226497476;8790.120987901159;8813.647454101892;11262.549498019987;11307.208495405243;11392.772144557062;11427.371494567878;11476;4645.883852903705;4785.880352991134;4806.591439727592;4854.466008739036;4856.247281671346;787.9054513458422;792.1721800718263;793.3970182661219;808.1554775259867;825.8885050518103;19013.049347532567;19164.233430662618;19355.4193374199;19517.609647806963;19522.804771952382;872.358816270041;879.9780005499914;887.2236792806294;888.7689200807837;889.4752096263236;9743.902560974442;10089.445080520642;10333.276670633133;10338.53476593555;10409.375437473624;176089;177435;177571;177766;178036.10981945007;35487.29025419477;35599.28801423957;35602.64397356045;35606.64393356085;35652.64347356545;1028.0336483705294;1063.5852017713098;1069.9411532365639;1070.03162138265;1075.6074032978063;18442.26230950747;18593.16330765146;19407.0296485178;19407.417777466697;19523.51191220231;26160.215193544223;26170.476590468465;26205.73794262033;26219.21342359732;26225.868870655526;143993;145618.27190863978;145792;145822.27088864488;146054.2697286507;26262.4747505045;26319.736802632495;26624.733752663;27396.45207095887;27595.86202068977;32373;32463.67536324701;32550.34899302048;32578.185545361557;32618.673813262514;23745.287641370785;24989.125380611593;25186.49627007413;25261.62107568425;25281.241562753148;24641.50716985686;24753.381165470288;25014.49971000606;25104.12135575246;26130.346741331618;28027.71972280251;28136.29659258535;28143.296417589725;28190.29524261828;28205.71794282031;23291.53416931686;24105.397365066012;24164.63753043741;24436.63345049861;24492.265232043068;19706.31027914016;20346.491337716674;20366.694499582816;20422.285220017227;20616.27843025547 14:12:06 INFO - PID 27709 | |2;jquery.html;398.58148943609206;400.73150988837494;408.85894366443586;417.4114498557035;421.4310680581216;12737.363131843395;13288.933555332234;16320.75518867218;16986.575335616617;16990.320387184514;15802.841971580281;16418.425355112573;16449.177541122925;16506.25721842517;16541.83458165418;5300.310959575249;5335.946640533583;5343.973280133613;5366.356037275513;5370.140777475604;5233.869153271161;5341.252224688527;5352.197170424429;5362.839114826542;5368.91946620801;5329;5341.092014357569;5343.038253114438;5343.866403339928;5347.197920311945;5133.153029750087;5349.839504814861;5357.196420536911;5374.408815030343;5398.568114550866;4867.488913664085;4892.021595680878;4905.3132561441425;4907.730074845882;4911.066897289504;21333.67999480009;21466.46333841651;21573.46066348338;21668;21724.674129888066;1654.7517872319129;1662;1686.5024817678814;1686.5867862373675;1702.3020561569697;14003.089799163023;14149.151050936875;14380.92809535956;14389.640258993504;14393.71212575753;2069.2136987944486;2094.2356040045424;2116.121809449077;2119.448943274744;2120.791149045045;101674.49162754213;104984;106031.46984265106;106400;106595;10108.39349639024;10512.632057877938;10700.357978521313;10734.94632526848;10886.427700365864;14762.261886905611;14868.107913525224;14871.628209294639;14926.552203433697;14944.327505262288;6719.428848547928;7085.14978202619;7113;7115.359617634438;7127.607981561064;6408.679566021773;6462.967685161544;6505.804825855232;6505.902411463831;6527.967360163264;6602.471802255808;6697.598144111369;6708.83227919306;6735.259121496631;6747.696353664097;1898.250191174506;1912.225548652798;1979.5941831924708;2020.0707674469616;2062.226665000625;750.8940982098262;782.3467404717125;793.3692714292151;803.5379656697422;805.5649949027577;15832.208389580475;16030.839691603169;16032.599185020235;16212.270447829877;16321.510354689379;793.9722109726132;794.6702118620708;798.9720359787495;801.2228138705447;822.457178262344;8694.608742606599;8738.432001919855;8761.956190219136;9091;9153.771155721028;325990;326122;326987;327840;333080;84129.57935210408;84409;85541.57229213814;85553;86226;908.5366463103865;935.6491315756591;955.5795450001976;955.9426434413957;960.1646567486192;13373.796358327798;16127.838721612634;16175.27211275519;16554.917225413796;17223.655526889142;44698.10603787971;45702.20126886762;45853.16587336603;46160;46245.53754462412;51421;51421;51675.22487162771;52013;52407;8943.060978597414;8982;9122.589483473392;9126.817463650557;9147.725568232963;12979.675508112372;14429.711405772036;14461;14483.275836208359;14530.27348632543;12746.936265318614;12793.87206127964;12820;12895.548655797002;12942.482300708243;11243.10055195566;11629.825552616887;11638.592649257236;11762;11766.235194712317;12208.694782630506;12254.816177757162;12272.44773985155;12343.629691109281;12363.93818030904;8966.417182883091;9221.631134754534;9222.769430764285;9245.861312080458;9435.858462122937;12802.807957880454;12818.807717884425;12827.140064690755;12840.935795320964;12881.806772898226 14:12:06 INFO - PID 27709 | |3;mootools.html;1056.6354607660357;1090.5147209491774;1109.9001089901908;1112.9721756956076;1120.2102517725004;9019.81960360794;9339.719808405742;9906;10402.167826573885;10409.427481488525;10088.949555252213;10425.791484170331;10425.947870260638;10433.582656693723;10435.582576696943;2089.83281337493;2136.8931553422344;2138.9037493312762;2139.732533433321;2143.217725530186;2080.1887263967064;2089.268755935418;2125.054350813881;2135.7437107547116;2169.1865550418593;2130.8295336373053;2155.0840892620654;2155.5581105873257;2155.741311042677;2162.826973842097;2044.131244221215;2058.423641380416;2075.1595603780493;2085.728855248808;2086.426232785981;2010.2662528177257;2029.5940811837545;2030.2285131650026;2034.4608678700156;2040.7347044884218;9634.662786802499;9811;9822.656207032791;9830.557624906825;9848.965858584888;5236.266922630834;5398.082326004549;5402.189671549259;5409.810656626999;5437.864053398657;3232.1111694284023;3299.7525185610934;3335.6831101045364;3405.9489107663403;3406.131436483706;1058.513083981362;1076.5855145768935;1081.2701426537055;1088.0642647323295;1095.1293721491434;16101.597460063475;16114;16231.675366492722;16261.593460163473;16267;4327.480702315742;4533.161365147458;4613.607843333287;4652.790624421841;4672.74299913508;10987.39569323679;11062.115030797517;11063.834042489369;11136.38749868765;11160.832587511193;5224.346956630421;5344.4922732340365;5348.545373643284;5358.356997160366;5373.650712703662;4931.630127740434;4951.579115775199;4975.427825800007;4981.252812078217;4982.8754281143265;3640.199156185635;3647.176411794103;3691.298653255873;3698.6116457772087;3771.321162190777;1023.6468418395641;1059.443792009186;1089.8637670291214;1100.8899110088928;1111.827666711661;620.030455895994;628.767356078254;650.6063831381946;651.2803352295645;654.731560060373;5465.890682186414;5581.888362232733;5638.984982703071;5745.770169193185;5852.005159122959;762.325342072259;785.2383188307447;786.2530595933771;786.8662327404355;799.4124318625805;3286.4084464796565;3476.774009689362;3516.08581768742;3560.4481305397703;3680.9447858282147;13921.791173132411;14111.941604379712;14365.425382984773;14470.493532726305;14538.27308634564;13995.51015714445;14347.497837575844;14420;14574.198419087052;14617.269136543344;7336.926630733731;7511.887321690179;7538.246175382527;7545.245475452411;7635.885461718079;5733.655980641175;5817.331006934257;5898.4101589840675;5899.292084949833;6034.547408944259;12259.203151795105;12864.421101050288;12867.163634363736;12872;12979;12742;12800.16798908068;12856.292903890377;12973.978066799322;13166.868331316948;8085.716999904975;8283.29591984688;8297.709580164665;8312.127226641116;8326.45878017927;9395.06049395055;9430.669926552539;9459.432434053979;9488.620455181715;9506.049395060438;7918.802029949067;8005.75982720496;8024.598770061357;8034.035915689921;8060.798480037812;7474.626268686653;7527.548347099191;7576.810579735551;7615.162332143349;7680.231976802275;6950.374466298057;7115.2528984455885;7137.0008198851165;7147.392471639969;7163.283671632795;4880.560749532559;4890.828820991248;4994.225894986283;5084.5932325414615;5199.63602547818;4828.130936431476;4947.529984651453;5041.218611115283;5048.848534543969;5122.795088196431 14:12:06 INFO - PID 27709 | |4;prototype.html;338.86445421831263;360.6699869619297;363.874463310158;369.4273875492986;370.62566807524394;5597.6641401515935;5619.80330688426;5680.687562184078;5687.431256874311;5712.11462223356;5500.532454741342;5604.85987850304;5607.588736843156;5618.101103823379;5626.071698169807;4343.239933011726;4346.804393802271;4347.174036932988;4350.521442641307;4351.543087975764;4189.6438802701805;4345;4345.109252603224;4362.367456718774;4374.562543745616;4288.1423715256915;4310;4318.438602981608;4325.956740432587;4329.718568293051;4307.181635489263;4325.740455572675;4326.113146804897;4336.631386332166;4338.8047537860875;3892.883213503571;3894.9026274343087;3896.7467114637743;3901.141748815256;3903.8048097595006;5483.177523371486;5507.972460137714;5509.586780991402;5510.319352597457;5520.613557051008;5108.2593024011685;5120.103981803207;5133.486651334874;5145.897082058375;5146.356705411824;5918.940810591882;5921.171036054956;5941;5947.732352044125;5952.678455402353;4312.676549258818;4328.848490302856;4340.155433940563;4349.217140914634;4356.43366362374;6015.488683461911;6143.170671959273;6205.627662340229;6277.4350308472;6315.494760419201;4162.687798415131;4350.891227719332;4368.650507959355;4372.256716358227;4398.318260669601;4422.402975598317;4445.26653102241;4454.086912182995;4454.394179405084;4461.196984542748;4985.725785081855;4990.6257030722845;5008.449070602231;5019.196928491497;5029.346184995927;5858.736356863951;5869.266341707286;5871.471567558855;5872.588918775645;5897;1558.8752899768217;1566.4439124110777;1566.6240102375348;1567.9921600392154;1568.56864362299;1010.3634710132717;1067.0823092140752;1076.8330908709163;1086.5870969031876;1109.5561775289948;5045.117104506697;5058.190689489664;5070.112730272188;5088.516590923857;5097.898042039138;5983.021290841629;6044.758209671564;6051.606645568112;6060.424259695322;6063.878722425527;5027.296178535008;5056.6713163644245;5057;5067.189249720027;5071.771770270347;3186.362727454472;3200.8719651214155;3213.534037564587;3222.323312104484;3224.9032529024166;5565.666060036411;5567.081431563827;5571.916421253684;5584.832455026356;5590.888182236414;6133.417325354084;6162.753489860445;6207.317195108625;6239.906401403982;6259.902932517658;5595.888082238333;5608.831735047955;5610.607257492018;5616.865591075365;5617.775288988395;6034.939650603438;6048.12302216185;6060.181875446935;6075.30134034574;6084.726187321669;5907.3501914790195;5950.196723442453;5960;5960.5827592068135;5970.910436343372;5540.7783688652;5594.580406469449;5611.775528978958;5617.32592088952;5626.567793645954;4236.940764808798;4401.361802538678;4446.622037126751;4460.464744230713;4465.218586747371;5914.881702365842;6088.756449741961;6104.9389506106145;6129.233845769279;6147.262328520606;5832.483554275834;5842.152887831326;5895.587308888336;5900.0529825158455;5904.114382842608;5692.48767610917;5856.180134781049;5888.1452342511975;5891.086881533369;5937.495312898279;5835.591508594527;5851.297844258716;5867.178594996789;5870.651739304312;5880.441358070976;5956;5998.25021872266;6000.129981152621;6014.27828660546;6016.789412370546;5735.640912906138;5774.307083150049;5774.48029677331;5802.303723553032;5824.679642619527 14:12:06 INFO - PID 27709 | |5;yui.html;601.4256385152174;605.442992446949;621.751299480208;632.1844820181966;642.2453617000024;12499.750004999905;12877.871221287784;12912.548060817862;14868.925655371735;15856.762148567781;14400.063995840263;14684.706305873877;14687.559373218794;14702.264886755645;14732.18972956487;673.7877568565887;674.4469534981317;675.199888132562;688.9596708969467;726.6512074204385;627.7520379450115;651.563452486835;671.7581670598605;673.10477065503;676.6109487044944;697.2051860878603;703.43022152057;717.7057406463351;728.2608152724962;734.9522281051741;699.9860002799941;700.2192555300854;700.7057036044848;701.3162166887295;703.549728173969;505.75723652646934;506.7111746304608;511.61373163261874;512.5796846585802;513.4198355857857;12936.417861196269;13101.08292419531;13112.541061062817;13120.081594288404;13152;13550.93224533871;13566.864331356659;13678;13861.653458663513;13873;11974.58088966882;12122.818157727641;12207.755844883053;12215.694607634792;12215.877841221563;2988.2977500287416;2999.460097182506;3004.4291584598855;3005;3010.71398217169;84370;86598.56700716518;87083.99999999936;88093.55953220192;89229.55385223032;11811.291322520676;11887.940560297144;12137.393130343447;12160.635180944586;12174.81737773934;15988.520344389686;18174.818251817313;19350.806491935182;19482;20266.898665506873;5953.136795164677;6052.818415447544;6090.33006369299;6099.4815440688035;6113.358097399798;2900.419916016805;2969.302213979713;2970.4059188162023;2987.1337312179226;3006.6091408116804;3299.224682199681;3500.824958752052;3568.4647302904773;3578.1233597768714;3578.731595130376;691.6610860678231;700.9544379615309;701.5650296816007;701.9473539484559;703.5637904499243;512.8512731307953;518.9221616757517;524.9081410753103;529.2616799564586;530.3026520126022;9521;9533.332666713402;9622.230221582256;9654.56554455037;9767.902320976842;550.3505863081522;557.6866479440939;558.9441055894378;564.0946281218667;564.156585904076;4231.4710661167355;4442.333649952533;4531.682782205214;4542.31865220213;4628.95371046292;83945;83984;84203;86873.13126868776;87723;74486;75227.87158192632;81098.59450702708;81154;81520;64758.35241647618;64961.67519162374;66277.6686116576;66767.66616166888;67400.32599673941;8921;8999.100089990949;9002.279817614444;9073.183413492818;9336.06639336061;29241.85379073091;29581.85209073941;29870.701292986792;30140.84929575426;30658.386832263677;37484.81257593694;37535;37577;37627.43558846565;38101.809490952364;10740.946295268473;10968.17738669587;11074.446277686244;11217;12561.434735436744;15359.308831102404;15454.922725386301;15485.225738712794;15517.00069797596;15851.048937063813;13773.104748191336;13874;13924.791128133289;13932.30338483092;14099.929500352433;13221.801672975105;13518.662033449242;13522.797158042835;13842.861571384157;14848.183349915858;14407.207603581903;14473.85526144725;14495.130292182503;14662.340194691478;14756.704865902408;10042.397456152654;10079.395236285847;10189.490525473844;10243.282970192313;10264.178865690577;10662.200334974752;10885.401302928414;11073.390963497084;11090.44547772592;11229.55081796719 14:12:06 INFO - PID 27709 | __end_tp_report 14:12:06 INFO - PID 27709 | __start_cc_report 14:12:06 INFO - PID 27709 | _x_x_mozilla_cycle_collect,398 14:12:06 INFO - PID 27709 | __end_cc_report 14:12:06 INFO - PID 27709 | __startTimestamp1496178726750__endTimestamp 14:12:06 INFO - PID 27709 | 14:12:06 INFO - PID 27709 | ------- Summary: start ------- 14:12:06 INFO - PID 27709 | Number of tests: 6 14:12:06 INFO - PID 27709 | 14:12:06 INFO - PID 27709 | [#0] dojo.html Cycles:165 Average:5238.00 Median:5369.89 stddev:609.91 (11.4%) stddev-sans-first:579.84 14:12:06 INFO - PID 27709 | Values: 2754.9 2776.5 2800.7 2808.1 2813.5 5213.9 5284.4 5321.7 5324.5 5331.5 5216.1 5275.1 5296.9 5318.3 5354.1 4736.6 4746.4 4772.0 4788.9 4815.4 4621.3 4788.7 4827.9 4832.3 4855.1 4621.5 4692.0 4757.0 4810.6 4812.3 4601.7 4764.1 4771.9 4785.0 4797.9 4719.3 4731.8 4733.9 4742.9 4756.9 5237.3 5321.5 5334.3 5339.9 5358.5 5666.0 5785.3 5804.1 5810.8 5819.8 5714.9 5716.3 5722.7 5728.1 5780.7 5346.9 5351.1 5352.8 5369.9 5409.5 5694.7 5775.5 5777.8 5854.1 5961.3 5583.1 5662.6 5671.8 5689.2 5696.1 5644.7 5656.0 5667.5 5686.0 5750.2 5525.3 5553.7 5599.9 5722.1 5726.8 5673.1 5713.2 5755.8 5762.4 5799.6 4807.4 4826.9 4848.1 4866.8 4875.0 4096.1 4117.8 4125.8 4139.4 4170.1 4735.5 4750.9 4755.7 4846.0 4848.0 5781.0 5785.0 5793.2 5794.2 5843.4 4823.6 4827.6 4827.9 4831.6 4858.5 4939.5 5008.6 5119.5 5120.5 5123.2 5280.3 5331.1 5338.3 5353.8 5372.4 5618.1 5666.7 5685.7 5707.0 5755.0 5219.4 5251.3 5303.9 5336.9 5344.1 5664.4 5665.3 5682.6 5690.6 5700.0 5712.7 5749.0 5790.4 5800.1 5801.6 5529.7 5567.1 5582.2 5607.6 5618.6 5548.4 5557.3 5558.4 5559.6 5572.1 5438.3 5470.8 5484.3 5516.4 5524.4 5580.3 5644.5 5673.7 5676.3 5686.0 5463.3 5469.0 5474.7 5493.6 5519.8 14:12:06 INFO - PID 27709 | 14:12:06 INFO - PID 27709 | [#1] ext.html Cycles:180 Average:28252.05 Median:28537.79 stddev:40233.80 (141.0%) stddev-sans-first:40293.11 14:12:06 INFO - PID 27709 | Values: 605.4 673.1 679.6 1078.6 1086.0 30006.4 30501.5 30552.8 30612.1 30621.7 29227.1 29574.8 29624.7 29670.0 29670.1 6192.0 6430.4 6644.5 6649.6 6671.9 6667.9 6772.4 6780.3 6789.0 6796.3 6748.5 6756.8 6818.5 6822.5 6824.5 6665.4 6728.1 6738.9 6778.6 6804.8 6549.4 6562.6 6574.5 6608.5 6637.5 28869.9 28883.7 29071.4 29126.7 29173.0 2673.1 2673.6 2690.8 2698.6 2704.4 22133.8 22359.2 22438.9 22493.3 22530.9 3007.6 3018.1 3022.0 3035.4 3050.2 131654.3 131860.0 132320.3 154495.0 158658.0 34197.7 34207.7 34315.0 34387.3 34416.5 35819.1 35836.0 35846.1 35942.9 36044.0 10833.1 10921.5 10922.7 10925.4 10987.7 8746.4 8758.4 8759.5 8790.1 8813.6 11262.5 11307.2 11392.8 11427.4 11476.0 4645.9 4785.9 4806.6 4854.5 4856.2 787.9 792.2 793.4 808.2 825.9 19013.0 19164.2 19355.4 19517.6 19522.8 872.4 880.0 887.2 888.8 889.5 9743.9 10089.4 10333.3 10338.5 10409.4 176089.0 177435.0 177571.0 177766.0 178036.1 35487.3 35599.3 35602.6 35606.6 35652.6 1028.0 1063.6 1069.9 1070.0 1075.6 18442.3 18593.2 19407.0 19407.4 19523.5 26160.2 26170.5 26205.7 26219.2 26225.9 143993.0 145618.3 145792.0 145822.3 146054.3 26262.5 26319.7 26624.7 27396.5 27595.9 32373.0 32463.7 32550.3 32578.2 32618.7 23745.3 24989.1 25186.5 25261.6 25281.2 24641.5 24753.4 25014.5 25104.1 26130.3 28027.7 28136.3 28143.3 28190.3 28205.7 23291.5 24105.4 24164.6 24436.6 24492.3 19706.3 20346.5 20366.7 20422.3 20616.3 14:12:06 INFO - PID 27709 | 14:12:06 INFO - PID 27709 | [#2] jquery.html Cycles:180 Average:24632.29 Median:399.66 stddev:55984.06 (14008.0%) stddev-sans-first:56111.55 14:12:06 INFO - PID 27709 | Values: 398.6 400.7 408.9 417.4 421.4 12737.4 13288.9 16320.8 16986.6 16990.3 15802.8 16418.4 16449.2 16506.3 16541.8 5300.3 5335.9 5344.0 5366.4 5370.1 5233.9 5341.3 5352.2 5362.8 5368.9 5329.0 5341.1 5343.0 5343.9 5347.2 5133.2 5349.8 5357.2 5374.4 5398.6 4867.5 4892.0 4905.3 4907.7 4911.1 21333.7 21466.5 21573.5 21668.0 21724.7 1654.8 1662.0 1686.5 1686.6 1702.3 14003.1 14149.2 14380.9 14389.6 14393.7 2069.2 2094.2 2116.1 2119.4 2120.8 101674.5 104984.0 106031.5 106400.0 106595.0 10108.4 10512.6 10700.4 10734.9 10886.4 14762.3 14868.1 14871.6 14926.6 14944.3 6719.4 7085.1 7113.0 7115.4 7127.6 6408.7 6463.0 6505.8 6505.9 6528.0 6602.5 6697.6 6708.8 6735.3 6747.7 1898.3 1912.2 1979.6 2020.1 2062.2 750.9 782.3 793.4 803.5 805.6 15832.2 16030.8 16032.6 16212.3 16321.5 794.0 794.7 799.0 801.2 822.5 8694.6 8738.4 8762.0 9091.0 9153.8 325990.0 326122.0 326987.0 327840.0 333080.0 84129.6 84409.0 85541.6 85553.0 86226.0 908.5 935.6 955.6 955.9 960.2 13373.8 16127.8 16175.3 16554.9 17223.7 44698.1 45702.2 45853.2 46160.0 46245.5 51421.0 51421.0 51675.2 52013.0 52407.0 8943.1 8982.0 9122.6 9126.8 9147.7 12979.7 14429.7 14461.0 14483.3 14530.3 12746.9 12793.9 12820.0 12895.5 12942.5 11243.1 11629.8 11638.6 11762.0 11766.2 12208.7 12254.8 12272.4 12343.6 12363.9 8966.4 9221.6 9222.8 9245.9 9435.9 12802.8 12818.8 12827.1 12840.9 12881.8 14:12:06 INFO - PID 27709 | 14:12:06 INFO - PID 27709 | [#3] mootools.html Cycles:180 Average:6305.36 Median:3734.97 stddev:4306.18 (115.3%) stddev-sans-first:4300.20 14:12:06 INFO - PID 27709 | Values: 1056.6 1090.5 1109.9 1113.0 1120.2 9019.8 9339.7 9906.0 10402.2 10409.4 10088.9 10425.8 10425.9 10433.6 10435.6 2089.8 2136.9 2138.9 2139.7 2143.2 2080.2 2089.3 2125.1 2135.7 2169.2 2130.8 2155.1 2155.6 2155.7 2162.8 2044.1 2058.4 2075.2 2085.7 2086.4 2010.3 2029.6 2030.2 2034.5 2040.7 9634.7 9811.0 9822.7 9830.6 9849.0 5236.3 5398.1 5402.2 5409.8 5437.9 3232.1 3299.8 3335.7 3405.9 3406.1 1058.5 1076.6 1081.3 1088.1 1095.1 16101.6 16114.0 16231.7 16261.6 16267.0 4327.5 4533.2 4613.6 4652.8 4672.7 10987.4 11062.1 11063.8 11136.4 11160.8 5224.3 5344.5 5348.5 5358.4 5373.7 4931.6 4951.6 4975.4 4981.3 4982.9 3640.2 3647.2 3691.3 3698.6 3771.3 1023.6 1059.4 1089.9 1100.9 1111.8 620.0 628.8 650.6 651.3 654.7 5465.9 5581.9 5639.0 5745.8 5852.0 762.3 785.2 786.3 786.9 799.4 3286.4 3476.8 3516.1 3560.4 3680.9 13921.8 14111.9 14365.4 14470.5 14538.3 13995.5 14347.5 14420.0 14574.2 14617.3 7336.9 7511.9 7538.2 7545.2 7635.9 5733.7 5817.3 5898.4 5899.3 6034.5 12259.2 12864.4 12867.2 12872.0 12979.0 12742.0 12800.2 12856.3 12974.0 13166.9 8085.7 8283.3 8297.7 8312.1 8326.5 9395.1 9430.7 9459.4 9488.6 9506.0 7918.8 8005.8 8024.6 8034.0 8060.8 7474.6 7527.5 7576.8 7615.2 7680.2 6950.4 7115.3 7137.0 7147.4 7163.3 4880.6 4890.8 4994.2 5084.6 5199.6 4828.1 4947.5 5041.2 5048.8 5122.8 14:12:06 INFO - PID 27709 | 14:12:06 INFO - PID 27709 | [#4] prototype.html Cycles:180 Average:4901.11 Median:5530.70 stddev:1408.14 (25.5%) stddev-sans-first:1369.83 14:12:06 INFO - PID 27709 | Values: 338.9 360.7 363.9 369.4 370.6 5597.7 5619.8 5680.7 5687.4 5712.1 5500.5 5604.9 5607.6 5618.1 5626.1 4343.2 4346.8 4347.2 4350.5 4351.5 4189.6 4345.0 4345.1 4362.4 4374.6 4288.1 4310.0 4318.4 4326.0 4329.7 4307.2 4325.7 4326.1 4336.6 4338.8 3892.9 3894.9 3896.7 3901.1 3903.8 5483.2 5508.0 5509.6 5510.3 5520.6 5108.3 5120.1 5133.5 5145.9 5146.4 5918.9 5921.2 5941.0 5947.7 5952.7 4312.7 4328.8 4340.2 4349.2 4356.4 6015.5 6143.2 6205.6 6277.4 6315.5 4162.7 4350.9 4368.7 4372.3 4398.3 4422.4 4445.3 4454.1 4454.4 4461.2 4985.7 4990.6 5008.4 5019.2 5029.3 5858.7 5869.3 5871.5 5872.6 5897.0 1558.9 1566.4 1566.6 1568.0 1568.6 1010.4 1067.1 1076.8 1086.6 1109.6 5045.1 5058.2 5070.1 5088.5 5097.9 5983.0 6044.8 6051.6 6060.4 6063.9 5027.3 5056.7 5057.0 5067.2 5071.8 3186.4 3200.9 3213.5 3222.3 3224.9 5565.7 5567.1 5571.9 5584.8 5590.9 6133.4 6162.8 6207.3 6239.9 6259.9 5595.9 5608.8 5610.6 5616.9 5617.8 6034.9 6048.1 6060.2 6075.3 6084.7 5907.4 5950.2 5960.0 5960.6 5970.9 5540.8 5594.6 5611.8 5617.3 5626.6 4236.9 4401.4 4446.6 4460.5 4465.2 5914.9 6088.8 6104.9 6129.2 6147.3 5832.5 5842.2 5895.6 5900.1 5904.1 5692.5 5856.2 5888.1 5891.1 5937.5 5835.6 5851.3 5867.2 5870.7 5880.4 5956.0 5998.3 6000.1 6014.3 6016.8 5735.6 5774.3 5774.5 5802.3 5824.7 14:12:06 INFO - PID 27709 | 14:12:06 INFO - PID 27709 | [#5] yui.html Cycles:180 Average:17150.78 Median:37509.91 stddev:23649.57 (63.0%) stddev-sans-first:23683.26 14:12:06 INFO - PID 27709 | Values: 601.4 605.4 621.8 632.2 642.2 12499.8 12877.9 12912.5 14868.9 15856.8 14400.1 14684.7 14687.6 14702.3 14732.2 673.8 674.4 675.2 689.0 726.7 627.8 651.6 671.8 673.1 676.6 697.2 703.4 717.7 728.3 735.0 700.0 700.2 700.7 701.3 703.5 505.8 506.7 511.6 512.6 513.4 12936.4 13101.1 13112.5 13120.1 13152.0 13550.9 13566.9 13678.0 13861.7 13873.0 11974.6 12122.8 12207.8 12215.7 12215.9 2988.3 2999.5 3004.4 3005.0 3010.7 84370.0 86598.6 87084.0 88093.6 89229.6 11811.3 11887.9 12137.4 12160.6 12174.8 15988.5 18174.8 19350.8 19482.0 20266.9 5953.1 6052.8 6090.3 6099.5 6113.4 2900.4 2969.3 2970.4 2987.1 3006.6 3299.2 3500.8 3568.5 3578.1 3578.7 691.7 701.0 701.6 701.9 703.6 512.9 518.9 524.9 529.3 530.3 9521.0 9533.3 9622.2 9654.6 9767.9 550.4 557.7 558.9 564.1 564.2 4231.5 4442.3 4531.7 4542.3 4629.0 83945.0 83984.0 84203.0 86873.1 87723.0 74486.0 75227.9 81098.6 81154.0 81520.0 64758.4 64961.7 66277.7 66767.7 67400.3 8921.0 8999.1 9002.3 9073.2 9336.1 29241.9 29581.9 29870.7 30140.8 30658.4 37484.8 37535.0 37577.0 37627.4 38101.8 10740.9 10968.2 11074.4 11217.0 12561.4 15359.3 15454.9 15485.2 15517.0 15851.0 13773.1 13874.0 13924.8 13932.3 14099.9 13221.8 13518.7 13522.8 13842.9 14848.2 14407.2 14473.9 14495.1 14662.3 14756.7 10042.4 10079.4 10189.5 10243.3 10264.2 10662.2 10885.4 11073.4 11090.4 11229.6 14:12:06 INFO - PID 27709 | -------- Summary: end -------- 14:12:06 INFO - PID 27709 | 14:12:07 INFO - TEST-INFO | 27709: exit 0 14:12:07 INFO - TEST-OK | dromaeo_css | took 1148886ms 14:12:07 INFO - TEST-START | kraken 14:12:07 INFO - operating with platform_type : linux_ 14:12:07 INFO - Initialising browser for kraken test... 14:12:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34077/getInfo.html -profile /tmp/tmpTfEj0J/profile 14:12:07 INFO - TEST-INFO | started process 28127 (/builds/slave/test/build/application/firefox/firefox http://localhost:34077/getInfo.html) 14:12:42 INFO - TEST-INFO | 28127: killed by SIGTERM 14:12:42 INFO - Browser initialized. 14:12:42 INFO - Running cycle 1/1 for kraken test... 14:12:42 INFO - TEST-INFO | started process 28349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTfEj0J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:55 INFO - PID 28349 | RSS: Main: 186863616 14:12:55 INFO - PID 28349 | 14:12:57 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34077/tests/kraken/driver.html?testName=audio-beat-detection) 14:12:58 INFO - PID 28349 | RSS: Main: 190144512 14:12:58 INFO - PID 28349 | 14:13:01 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34077/tests/kraken/driver.html?testName=audio-dft) 14:13:02 INFO - PID 28349 | RSS: Main: 189382656 14:13:02 INFO - PID 28349 | 14:13:05 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34077/tests/kraken/driver.html?testName=audio-fft) 14:13:05 INFO - PID 28349 | RSS: Main: 185466880 14:13:05 INFO - PID 28349 | 14:13:07 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34077/tests/kraken/driver.html?testName=audio-oscillator) 14:13:08 INFO - PID 28349 | RSS: Main: 185442304 14:13:08 INFO - PID 28349 | 14:13:10 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34077/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:13:11 INFO - PID 28349 | RSS: Main: 185790464 14:13:11 INFO - PID 28349 | 14:13:14 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34077/tests/kraken/driver.html?testName=imaging-darkroom) 14:13:15 INFO - PID 28349 | RSS: Main: 189943808 14:13:15 INFO - PID 28349 | 14:13:18 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34077/tests/kraken/driver.html?testName=imaging-desaturate) 14:13:19 INFO - PID 28349 | RSS: Main: 185438208 14:13:19 INFO - PID 28349 | 14:13:22 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34077/tests/kraken/driver.html?testName=json-parse-financial) 14:13:22 INFO - PID 28349 | RSS: Main: 186388480 14:13:22 INFO - PID 28349 | 14:13:24 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34077/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:13:25 INFO - PID 28349 | RSS: Main: 186548224 14:13:25 INFO - PID 28349 | 14:13:26 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:13:27 INFO - PID 28349 | RSS: Main: 186507264 14:13:27 INFO - PID 28349 | 14:13:29 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:13:30 INFO - PID 28349 | RSS: Main: 186454016 14:13:30 INFO - PID 28349 | 14:13:33 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:13:34 INFO - PID 28349 | RSS: Main: 186310656 14:13:34 INFO - PID 28349 | 14:13:37 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:13:37 INFO - PID 28349 | RSS: Main: 186515456 14:13:37 INFO - PID 28349 | 14:13:39 INFO - PID 28349 | Cycle 1(1): loaded http://localhost:34077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34077/tests/kraken/driver.html?testName=ai-astar) 14:13:40 INFO - PID 28349 | RSS: Main: 187588608 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | __start_tp_report 14:13:40 INFO - PID 28349 | _x_x_mozilla_page_load 14:13:40 INFO - PID 28349 | _x_x_mozilla_page_load_details 14:13:40 INFO - PID 28349 | |i|pagename|runs| 14:13:40 INFO - PID 28349 | |0;ai-astar;102;113;116;109;109;111;111;110;110;111 14:13:40 INFO - PID 28349 | |1;audio-beat-detection;155;122;123;171;127;127;124;122;149;123 14:13:40 INFO - PID 28349 | |2;audio-dft;165;166;167;173;180;170;165;165;165;166 14:13:40 INFO - PID 28349 | |3;audio-fft;74;74;74;105;75;74;76;77;93;74 14:13:40 INFO - PID 28349 | |4;audio-oscillator;84;83;115;84;85;83;98;84;83;110 14:13:40 INFO - PID 28349 | |5;imaging-gaussian-blur;117;121;114;115;115;114;114;114;113;114 14:13:40 INFO - PID 28349 | |6;imaging-darkroom;151;150;151;150;151;151;151;152;150;151 14:13:40 INFO - PID 28349 | |7;imaging-desaturate;94;96;95;95;98;95;94;95;100;95 14:13:40 INFO - PID 28349 | |8;json-parse-financial;55;57;56;54;56;55;58;55;56;59 14:13:40 INFO - PID 28349 | |9;json-stringify-tinderbox;55;56;57;56;56;55;65;55;55;56 14:13:40 INFO - PID 28349 | |10;stanford-crypto-aes;87;98;90;96;95;90;88;88;125;86 14:13:40 INFO - PID 28349 | |11;stanford-crypto-ccm;135;131;138;147;136;131;129;135;135;159 14:13:40 INFO - PID 28349 | |12;stanford-crypto-pbkdf2;187;189;201;193;192;196;202;193;198;191 14:13:40 INFO - PID 28349 | |13;stanford-crypto-sha256-iterative;74;76;73;73;72;73;75;75;74;71 14:13:40 INFO - PID 28349 | __end_tp_report 14:13:40 INFO - PID 28349 | __start_cc_report 14:13:40 INFO - PID 28349 | _x_x_mozilla_cycle_collect,1016 14:13:40 INFO - PID 28349 | __end_cc_report 14:13:40 INFO - PID 28349 | __startTimestamp1496178820030__endTimestamp 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | ------- Summary: start ------- 14:13:40 INFO - PID 28349 | Number of tests: 14 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.55 (3.2%) stddev-sans-first:2.20 14:13:40 INFO - PID 28349 | Values: 102.0 113.0 116.0 109.0 109.0 111.0 111.0 110.0 110.0 111.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:127.00 stddev:17.52 (13.8%) stddev-sans-first:16.90 14:13:40 INFO - PID 28349 | Values: 155.0 122.0 123.0 171.0 127.0 127.0 124.0 122.0 149.0 123.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#2] audio-dft Cycles:10 Average:168.20 Median:166.50 stddev:4.92 (3.0%) stddev-sans-first:5.08 14:13:40 INFO - PID 28349 | Values: 165.0 166.0 167.0 173.0 180.0 170.0 165.0 165.0 165.0 166.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#3] audio-fft Cycles:10 Average:79.60 Median:74.50 stddev:10.66 (14.3%) stddev-sans-first:11.11 14:13:40 INFO - PID 28349 | Values: 74.0 74.0 74.0 105.0 75.0 74.0 76.0 77.0 93.0 74.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.00 stddev:12.30 (14.6%) stddev-sans-first:12.79 14:13:40 INFO - PID 28349 | Values: 84.0 83.0 115.0 84.0 85.0 83.0 98.0 84.0 83.0 110.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:114.50 stddev:2.33 (2.0%) stddev-sans-first:2.37 14:13:40 INFO - PID 28349 | Values: 117.0 121.0 114.0 115.0 115.0 114.0 114.0 114.0 113.0 114.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:13:40 INFO - PID 28349 | Values: 151.0 150.0 151.0 150.0 151.0 151.0 151.0 152.0 150.0 151.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:1.89 (2.0%) stddev-sans-first:1.90 14:13:40 INFO - PID 28349 | Values: 94.0 96.0 95.0 95.0 98.0 95.0 94.0 95.0 100.0 95.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.52 (2.7%) stddev-sans-first:1.56 14:13:40 INFO - PID 28349 | Values: 55.0 57.0 56.0 54.0 56.0 55.0 58.0 55.0 56.0 59.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:56.00 stddev:3.03 (5.4%) stddev-sans-first:3.15 14:13:40 INFO - PID 28349 | Values: 55.0 56.0 57.0 56.0 56.0 55.0 65.0 55.0 55.0 56.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:90.00 stddev:11.54 (12.8%) stddev-sans-first:11.93 14:13:40 INFO - PID 28349 | Values: 87.0 98.0 90.0 96.0 95.0 90.0 88.0 88.0 125.0 86.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:135.50 stddev:9.01 (6.6%) stddev-sans-first:9.51 14:13:40 INFO - PID 28349 | Values: 135.0 131.0 138.0 147.0 136.0 131.0 129.0 135.0 135.0 159.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.20 Median:194.50 stddev:4.96 (2.6%) stddev-sans-first:4.53 14:13:40 INFO - PID 28349 | Values: 187.0 189.0 201.0 193.0 192.0 196.0 202.0 193.0 198.0 191.0 14:13:40 INFO - PID 28349 | 14:13:40 INFO - PID 28349 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.00 stddev:1.51 (2.0%) stddev-sans-first:1.59 14:13:40 INFO - PID 28349 | Values: 74.0 76.0 73.0 73.0 72.0 73.0 75.0 75.0 74.0 71.0 14:13:40 INFO - PID 28349 | -------- Summary: end -------- 14:13:40 INFO - PID 28349 | 14:13:41 INFO - TEST-INFO | 28349: exit 0 14:13:41 INFO - TEST-OK | kraken | took 93625ms 14:13:41 INFO - SUITE-END | took 1242s 14:13:41 INFO - Completed test suite (00:20:42) 14:13:41 INFO - javascript benchmark 14:13:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6595.846787431574, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2754.8622568871556, 2776.472470230657, 2800.6919238883734, 2808.129479861243, 2813.5217013107763, 5213.86965325867, 5284.445133261005, 5321.7073060981675, 5324.520793128618, 5331.520163185312, 5216.113260745673, 5275.129603615399, 5296.894062118756, 5318.2554442378005, 5354.14333706607, 4736.644751643623, 4746.382970213867, 4772.04559088182, 4788.928166077511, 4815.446223684268, 4621.2837010263465, 4788.736619485927, 4827.903441931159, 4832.275158726184, 4855.126077306083, 4621.4685311189305, 4692.0, 4757.0, 4810.615150787964, 4812.254100614393, 4601.700889442175, 4764.142454358214, 4771.856844294677, 4784.952150478485, 4797.880052998668, 4719.315699223594, 4731.787069581843, 4733.905321893577, 4742.857714268577, 4756.9286460703115, 5237.319148510707, 5321.467853214686, 5334.279872217278, 5339.866503337409, 5358.490943360413, 5666.036773748473, 5785.334686511063, 5804.071348584249, 5810.796622118206, 5819.82540523785, 5714.914166308429, 5716.256886604757, 5722.713864306768, 5728.054870946289, 5780.739866706008, 5346.893062138735, 5351.09031464652, 5352.759125839347, 5369.892602147975, 5409.486098820606, 5694.743736531866, 5775.5090817281, 5777.7977770777825, 5854.121881717691, 5961.344252132262, 5583.078791999355, 5662.603617746719, 5671.773129074873, 5689.2319536862, 5696.145578163226, 5644.74598643062, 5656.0, 5667.518260947865, 5686.0333743263745, 5750.2237197978575, 5525.254090697785, 5553.722313884289, 5599.888002239933, 5722.141678748221, 5726.828195154068, 5673.092305231144, 5713.171590119493, 5755.827325180251, 5762.394948530344, 5799.6230245034785, 4807.351007613997, 4826.927596086061, 4848.0788650156355, 4866.8053277868485, 4875.024995001014, 4096.139810639739, 4117.835286588563, 4125.834966601363, 4139.379093136054, 4170.124273902515, 4735.502772208937, 4750.904981900343, 4755.667103302736, 4846.030793841246, 4847.975760121177, 5781.017227071408, 5784.971075144597, 5793.24687790593, 5794.246747922827, 5843.415658434123, 4823.614110871122, 4827.565519103297, 4827.927581086286, 4831.589314908202, 4858.514148585114, 4939.456659767423, 5008.599312055099, 5119.462456442095, 5120.513551212629, 5123.231515272664, 5280.260763493037, 5331.067063263991, 5338.3060202173465, 5353.785848566014, 5372.435894231206, 5618.129189975561, 5666.744996475086, 5685.744141513559, 5706.9727449059565, 5755.0, 5219.373675158853, 5251.317328747238, 5303.867403314794, 5336.852576696029, 5344.064788662046, 5664.405237450009, 5665.263515742927, 5682.602217844877, 5690.573207009574, 5700.0, 5712.65724056558, 5749.0, 5790.392008839011, 5800.100984347433, 5801.564882633904, 5529.668219906818, 5567.081431563746, 5582.246396736388, 5607.579431542569, 5618.550515958796, 5548.361938377138, 5557.3331200256225, 5558.44415558441, 5559.58303127259, 5572.080606699849, 5438.265834112344, 5470.835874923759, 5484.314460692413, 5516.393196748274, 5524.392316845064, 5580.330360356783, 5644.491995720405, 5673.74468148926, 5676.347220069745, 5686.033374326292, 5463.344398672026, 5469.042917489503, 5474.671519708831, 5493.615446918837, 5519.806806761905], "value": 5194.260008025466, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.4339192854678, 673.0644404278054, 679.6499802601661, 1078.6170909327188, 1085.9728506787335, 30006.399872002574, 30501.542476862836, 30552.847235763846, 30612.08163755091, 30621.69378306216, 29227.123186304445, 29574.824405728967, 29624.703752962465, 29670.0, 29670.10989670308, 6192.040233763774, 6430.421262086411, 6644.501662375317, 6649.634270115142, 6671.933280667204, 6667.899981500282, 6772.424343930772, 6780.321967803229, 6789.049533065375, 6796.2863899290605, 6748.4938629602975, 6756.797296081101, 6818.488613353993, 6822.454203663719, 6824.488163387741, 6665.400113989765, 6728.125343705336, 6738.865222695567, 6778.5593936394225, 6804.795856124275, 6549.443297319734, 6562.573432726857, 6574.506911981573, 6608.504362172856, 6637.502187335969, 28869.855650721824, 28883.711162888314, 29071.41857162845, 29126.70873291261, 29173.0, 2673.064427450396, 2673.639058727066, 2690.8385496870055, 2698.649175607178, 2704.3779930615874, 22133.778662213495, 22359.217427390126, 22438.88780556103, 22493.32520024402, 22530.887345563333, 3007.5639032340187, 3018.1247438242885, 3022.0480548627334, 3035.3777475617444, 3050.23744063984, 131654.3417282917, 131860.0, 132320.3383983074, 154495.0, 158658.0, 34197.65802341994, 34207.65792342094, 34315.0, 34387.31225375478, 34416.48375274373, 35819.104522386624, 35836.0, 35846.1038474035, 35942.86657034475, 36044.0, 10833.079188269085, 10921.508532116073, 10922.726931826768, 10925.399103049249, 10987.670369888916, 8746.431481953652, 8758.386912916034, 8759.518226497476, 8790.120987901159, 8813.647454101892, 11262.549498019987, 11307.208495405243, 11392.772144557062, 11427.371494567878, 11476.0, 4645.883852903705, 4785.880352991134, 4806.591439727592, 4854.466008739036, 4856.247281671346, 787.9054513458422, 792.1721800718263, 793.3970182661219, 808.1554775259867, 825.8885050518103, 19013.049347532567, 19164.233430662618, 19355.4193374199, 19517.609647806963, 19522.804771952382, 872.358816270041, 879.9780005499914, 887.2236792806294, 888.7689200807837, 889.4752096263236, 9743.902560974442, 10089.445080520642, 10333.276670633133, 10338.53476593555, 10409.375437473624, 176089.0, 177435.0, 177571.0, 177766.0, 178036.10981945007, 35487.29025419477, 35599.28801423957, 35602.64397356045, 35606.64393356085, 35652.64347356545, 1028.0336483705294, 1063.5852017713098, 1069.9411532365639, 1070.03162138265, 1075.6074032978063, 18442.26230950747, 18593.16330765146, 19407.0296485178, 19407.417777466697, 19523.51191220231, 26160.215193544223, 26170.476590468465, 26205.73794262033, 26219.21342359732, 26225.868870655526, 143993.0, 145618.27190863978, 145792.0, 145822.27088864488, 146054.2697286507, 26262.4747505045, 26319.736802632495, 26624.733752663, 27396.45207095887, 27595.86202068977, 32373.0, 32463.67536324701, 32550.34899302048, 32578.185545361557, 32618.673813262514, 23745.287641370785, 24989.125380611593, 25186.49627007413, 25261.62107568425, 25281.241562753148, 24641.50716985686, 24753.381165470288, 25014.49971000606, 25104.12135575246, 26130.346741331618, 28027.71972280251, 28136.29659258535, 28143.296417589725, 28190.29524261828, 28205.71794282031, 23291.53416931686, 24105.397365066012, 24164.63753043741, 24436.63345049861, 24492.265232043068, 19706.31027914016, 20346.491337716674, 20366.694499582816, 20422.285220017227, 20616.27843025547], "value": 13238.6469752476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.58148943609206, 400.73150988837494, 408.85894366443586, 417.4114498557035, 421.4310680581216, 12737.363131843395, 13288.933555332234, 16320.75518867218, 16986.575335616617, 16990.320387184514, 15802.841971580281, 16418.425355112573, 16449.177541122925, 16506.25721842517, 16541.83458165418, 5300.310959575249, 5335.946640533583, 5343.973280133613, 5366.356037275513, 5370.140777475604, 5233.869153271161, 5341.252224688527, 5352.197170424429, 5362.839114826542, 5368.91946620801, 5329.0, 5341.092014357569, 5343.038253114438, 5343.866403339928, 5347.197920311945, 5133.153029750087, 5349.839504814861, 5357.196420536911, 5374.408815030343, 5398.568114550866, 4867.488913664085, 4892.021595680878, 4905.3132561441425, 4907.730074845882, 4911.066897289504, 21333.67999480009, 21466.46333841651, 21573.46066348338, 21668.0, 21724.674129888066, 1654.7517872319129, 1662.0, 1686.5024817678814, 1686.5867862373675, 1702.3020561569697, 14003.089799163023, 14149.151050936875, 14380.92809535956, 14389.640258993504, 14393.71212575753, 2069.2136987944486, 2094.2356040045424, 2116.121809449077, 2119.448943274744, 2120.791149045045, 101674.49162754213, 104984.0, 106031.46984265106, 106400.0, 106595.0, 10108.39349639024, 10512.632057877938, 10700.357978521313, 10734.94632526848, 10886.427700365864, 14762.261886905611, 14868.107913525224, 14871.628209294639, 14926.552203433697, 14944.327505262288, 6719.428848547928, 7085.14978202619, 7113.0, 7115.359617634438, 7127.607981561064, 6408.679566021773, 6462.967685161544, 6505.804825855232, 6505.902411463831, 6527.967360163264, 6602.471802255808, 6697.598144111369, 6708.83227919306, 6735.259121496631, 6747.696353664097, 1898.250191174506, 1912.225548652798, 1979.5941831924708, 2020.0707674469616, 2062.226665000625, 750.8940982098262, 782.3467404717125, 793.3692714292151, 803.5379656697422, 805.5649949027577, 15832.208389580475, 16030.839691603169, 16032.599185020235, 16212.270447829877, 16321.510354689379, 793.9722109726132, 794.6702118620708, 798.9720359787495, 801.2228138705447, 822.457178262344, 8694.608742606599, 8738.432001919855, 8761.956190219136, 9091.0, 9153.771155721028, 325990.0, 326122.0, 326987.0, 327840.0, 333080.0, 84129.57935210408, 84409.0, 85541.57229213814, 85553.0, 86226.0, 908.5366463103865, 935.6491315756591, 955.5795450001976, 955.9426434413957, 960.1646567486192, 13373.796358327798, 16127.838721612634, 16175.27211275519, 16554.917225413796, 17223.655526889142, 44698.10603787971, 45702.20126886762, 45853.16587336603, 46160.0, 46245.53754462412, 51421.0, 51421.0, 51675.22487162771, 52013.0, 52407.0, 8943.060978597414, 8982.0, 9122.589483473392, 9126.817463650557, 9147.725568232963, 12979.675508112372, 14429.711405772036, 14461.0, 14483.275836208359, 14530.27348632543, 12746.936265318614, 12793.87206127964, 12820.0, 12895.548655797002, 12942.482300708243, 11243.10055195566, 11629.825552616887, 11638.592649257236, 11762.0, 11766.235194712317, 12208.694782630506, 12254.816177757162, 12272.44773985155, 12343.629691109281, 12363.93818030904, 8966.417182883091, 9221.631134754534, 9222.769430764285, 9245.861312080458, 9435.858462122937, 12802.807957880454, 12818.807717884425, 12827.140064690755, 12840.935795320964, 12881.806772898226], "value": 8822.850363641575, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1056.6354607660357, 1090.5147209491774, 1109.9001089901908, 1112.9721756956076, 1120.2102517725004, 9019.81960360794, 9339.719808405742, 9906.0, 10402.167826573885, 10409.427481488525, 10088.949555252213, 10425.791484170331, 10425.947870260638, 10433.582656693723, 10435.582576696943, 2089.83281337493, 2136.8931553422344, 2138.9037493312762, 2139.732533433321, 2143.217725530186, 2080.1887263967064, 2089.268755935418, 2125.054350813881, 2135.7437107547116, 2169.1865550418593, 2130.8295336373053, 2155.0840892620654, 2155.5581105873257, 2155.741311042677, 2162.826973842097, 2044.131244221215, 2058.423641380416, 2075.1595603780493, 2085.728855248808, 2086.426232785981, 2010.2662528177257, 2029.5940811837545, 2030.2285131650026, 2034.4608678700156, 2040.7347044884218, 9634.662786802499, 9811.0, 9822.656207032791, 9830.557624906825, 9848.965858584888, 5236.266922630834, 5398.082326004549, 5402.189671549259, 5409.810656626999, 5437.864053398657, 3232.1111694284023, 3299.7525185610934, 3335.6831101045364, 3405.9489107663403, 3406.131436483706, 1058.513083981362, 1076.5855145768935, 1081.2701426537055, 1088.0642647323295, 1095.1293721491434, 16101.597460063475, 16114.0, 16231.675366492722, 16261.593460163473, 16267.0, 4327.480702315742, 4533.161365147458, 4613.607843333287, 4652.790624421841, 4672.74299913508, 10987.39569323679, 11062.115030797517, 11063.834042489369, 11136.38749868765, 11160.832587511193, 5224.346956630421, 5344.4922732340365, 5348.545373643284, 5358.356997160366, 5373.650712703662, 4931.630127740434, 4951.579115775199, 4975.427825800007, 4981.252812078217, 4982.8754281143265, 3640.199156185635, 3647.176411794103, 3691.298653255873, 3698.6116457772087, 3771.321162190777, 1023.6468418395641, 1059.443792009186, 1089.8637670291214, 1100.8899110088928, 1111.827666711661, 620.030455895994, 628.767356078254, 650.6063831381946, 651.2803352295645, 654.731560060373, 5465.890682186414, 5581.888362232733, 5638.984982703071, 5745.770169193185, 5852.005159122959, 762.325342072259, 785.2383188307447, 786.2530595933771, 786.8662327404355, 799.4124318625805, 3286.4084464796565, 3476.774009689362, 3516.08581768742, 3560.4481305397703, 3680.9447858282147, 13921.791173132411, 14111.941604379712, 14365.425382984773, 14470.493532726305, 14538.27308634564, 13995.51015714445, 14347.497837575844, 14420.0, 14574.198419087052, 14617.269136543344, 7336.926630733731, 7511.887321690179, 7538.246175382527, 7545.245475452411, 7635.885461718079, 5733.655980641175, 5817.331006934257, 5898.4101589840675, 5899.292084949833, 6034.547408944259, 12259.203151795105, 12864.421101050288, 12867.163634363736, 12872.0, 12979.0, 12742.0, 12800.16798908068, 12856.292903890377, 12973.978066799322, 13166.868331316948, 8085.716999904975, 8283.29591984688, 8297.709580164665, 8312.127226641116, 8326.45878017927, 9395.06049395055, 9430.669926552539, 9459.432434053979, 9488.620455181715, 9506.049395060438, 7918.802029949067, 8005.75982720496, 8024.598770061357, 8034.035915689921, 8060.798480037812, 7474.626268686653, 7527.548347099191, 7576.810579735551, 7615.162332143349, 7680.231976802275, 6950.374466298057, 7115.2528984455885, 7137.0008198851165, 7147.392471639969, 7163.283671632795, 4880.560749532559, 4890.828820991248, 4994.225894986283, 5084.5932325414615, 5199.63602547818, 4828.130936431476, 4947.529984651453, 5041.218611115283, 5048.848534543969, 5122.795088196431], "value": 4633.333070352407, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.86445421831263, 360.6699869619297, 363.874463310158, 369.4273875492986, 370.62566807524394, 5597.6641401515935, 5619.80330688426, 5680.687562184078, 5687.431256874311, 5712.11462223356, 5500.532454741342, 5604.85987850304, 5607.588736843156, 5618.101103823379, 5626.071698169807, 4343.239933011726, 4346.804393802271, 4347.174036932988, 4350.521442641307, 4351.543087975764, 4189.6438802701805, 4345.0, 4345.109252603224, 4362.367456718774, 4374.562543745616, 4288.1423715256915, 4310.0, 4318.438602981608, 4325.956740432587, 4329.718568293051, 4307.181635489263, 4325.740455572675, 4326.113146804897, 4336.631386332166, 4338.8047537860875, 3892.883213503571, 3894.9026274343087, 3896.7467114637743, 3901.141748815256, 3903.8048097595006, 5483.177523371486, 5507.972460137714, 5509.586780991402, 5510.319352597457, 5520.613557051008, 5108.2593024011685, 5120.103981803207, 5133.486651334874, 5145.897082058375, 5146.356705411824, 5918.940810591882, 5921.171036054956, 5941.0, 5947.732352044125, 5952.678455402353, 4312.676549258818, 4328.848490302856, 4340.155433940563, 4349.217140914634, 4356.43366362374, 6015.488683461911, 6143.170671959273, 6205.627662340229, 6277.4350308472, 6315.494760419201, 4162.687798415131, 4350.891227719332, 4368.650507959355, 4372.256716358227, 4398.318260669601, 4422.402975598317, 4445.26653102241, 4454.086912182995, 4454.394179405084, 4461.196984542748, 4985.725785081855, 4990.6257030722845, 5008.449070602231, 5019.196928491497, 5029.346184995927, 5858.736356863951, 5869.266341707286, 5871.471567558855, 5872.588918775645, 5897.0, 1558.8752899768217, 1566.4439124110777, 1566.6240102375348, 1567.9921600392154, 1568.56864362299, 1010.3634710132717, 1067.0823092140752, 1076.8330908709163, 1086.5870969031876, 1109.5561775289948, 5045.117104506697, 5058.190689489664, 5070.112730272188, 5088.516590923857, 5097.898042039138, 5983.021290841629, 6044.758209671564, 6051.606645568112, 6060.424259695322, 6063.878722425527, 5027.296178535008, 5056.6713163644245, 5057.0, 5067.189249720027, 5071.771770270347, 3186.362727454472, 3200.8719651214155, 3213.534037564587, 3222.323312104484, 3224.9032529024166, 5565.666060036411, 5567.081431563827, 5571.916421253684, 5584.832455026356, 5590.888182236414, 6133.417325354084, 6162.753489860445, 6207.317195108625, 6239.906401403982, 6259.902932517658, 5595.888082238333, 5608.831735047955, 5610.607257492018, 5616.865591075365, 5617.775288988395, 6034.939650603438, 6048.12302216185, 6060.181875446935, 6075.30134034574, 6084.726187321669, 5907.3501914790195, 5950.196723442453, 5960.0, 5960.5827592068135, 5970.910436343372, 5540.7783688652, 5594.580406469449, 5611.775528978958, 5617.32592088952, 5626.567793645954, 4236.940764808798, 4401.361802538678, 4446.622037126751, 4460.464744230713, 4465.218586747371, 5914.881702365842, 6088.756449741961, 6104.9389506106145, 6129.233845769279, 6147.262328520606, 5832.483554275834, 5842.152887831326, 5895.587308888336, 5900.0529825158455, 5904.114382842608, 5692.48767610917, 5856.180134781049, 5888.1452342511975, 5891.086881533369, 5937.495312898279, 5835.591508594527, 5851.297844258716, 5867.178594996789, 5870.651739304312, 5880.441358070976, 5956.0, 5998.25021872266, 6000.129981152621, 6014.27828660546, 6016.789412370546, 5735.640912906138, 5774.307083150049, 5774.48029677331, 5802.303723553032, 5824.679642619527], "value": 4463.000014135526, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.4256385152174, 605.442992446949, 621.751299480208, 632.1844820181966, 642.2453617000024, 12499.750004999905, 12877.871221287784, 12912.548060817862, 14868.925655371735, 15856.762148567781, 14400.063995840263, 14684.706305873877, 14687.559373218794, 14702.264886755645, 14732.18972956487, 673.7877568565887, 674.4469534981317, 675.199888132562, 688.9596708969467, 726.6512074204385, 627.7520379450115, 651.563452486835, 671.7581670598605, 673.10477065503, 676.6109487044944, 697.2051860878603, 703.43022152057, 717.7057406463351, 728.2608152724962, 734.9522281051741, 699.9860002799941, 700.2192555300854, 700.7057036044848, 701.3162166887295, 703.549728173969, 505.75723652646934, 506.7111746304608, 511.61373163261874, 512.5796846585802, 513.4198355857857, 12936.417861196269, 13101.08292419531, 13112.541061062817, 13120.081594288404, 13152.0, 13550.93224533871, 13566.864331356659, 13678.0, 13861.653458663513, 13873.0, 11974.58088966882, 12122.818157727641, 12207.755844883053, 12215.694607634792, 12215.877841221563, 2988.2977500287416, 2999.460097182506, 3004.4291584598855, 3005.0, 3010.71398217169, 84370.0, 86598.56700716518, 87083.99999999936, 88093.55953220192, 89229.55385223032, 11811.291322520676, 11887.940560297144, 12137.393130343447, 12160.635180944586, 12174.81737773934, 15988.520344389686, 18174.818251817313, 19350.806491935182, 19482.0, 20266.898665506873, 5953.136795164677, 6052.818415447544, 6090.33006369299, 6099.4815440688035, 6113.358097399798, 2900.419916016805, 2969.302213979713, 2970.4059188162023, 2987.1337312179226, 3006.6091408116804, 3299.224682199681, 3500.824958752052, 3568.4647302904773, 3578.1233597768714, 3578.731595130376, 691.6610860678231, 700.9544379615309, 701.5650296816007, 701.9473539484559, 703.5637904499243, 512.8512731307953, 518.9221616757517, 524.9081410753103, 529.2616799564586, 530.3026520126022, 9521.0, 9533.332666713402, 9622.230221582256, 9654.56554455037, 9767.902320976842, 550.3505863081522, 557.6866479440939, 558.9441055894378, 564.0946281218667, 564.156585904076, 4231.4710661167355, 4442.333649952533, 4531.682782205214, 4542.31865220213, 4628.95371046292, 83945.0, 83984.0, 84203.0, 86873.13126868776, 87723.0, 74486.0, 75227.87158192632, 81098.59450702708, 81154.0, 81520.0, 64758.35241647618, 64961.67519162374, 66277.6686116576, 66767.66616166888, 67400.32599673941, 8921.0, 8999.100089990949, 9002.279817614444, 9073.183413492818, 9336.06639336061, 29241.85379073091, 29581.85209073941, 29870.701292986792, 30140.84929575426, 30658.386832263677, 37484.81257593694, 37535.0, 37577.0, 37627.43558846565, 38101.809490952364, 10740.946295268473, 10968.17738669587, 11074.446277686244, 11217.0, 12561.434735436744, 15359.308831102404, 15454.922725386301, 15485.225738712794, 15517.00069797596, 15851.048937063813, 13773.104748191336, 13874.0, 13924.791128133289, 13932.30338483092, 14099.929500352433, 13221.801672975105, 13518.662033449242, 13522.797158042835, 13842.861571384157, 14848.183349915858, 14407.207603581903, 14473.85526144725, 14495.130292182503, 14662.340194691478, 14756.704865902408, 10042.397456152654, 10079.395236285847, 10189.490525473844, 10243.282970192313, 10264.178865690577, 10662.200334974752, 10885.401302928414, 11073.390963497084, 11090.44547772592, 11229.55081796719], "value": 6562.947938123228, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 116.0, 109.0, 109.0, 111.0, 111.0, 110.0, 110.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 123.0, 171.0, 127.0, 127.0, 124.0, 122.0, 149.0, 123.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 167.0, 173.0, 180.0, 170.0, 165.0, 165.0, 165.0, 166.0], "value": 168.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 105.0, 75.0, 74.0, 76.0, 77.0, 93.0, 74.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 115.0, 84.0, 85.0, 83.0, 98.0, 84.0, 83.0, 110.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 151.0, 151.0, 151.0, 152.0, 150.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 98.0, 95.0, 94.0, 95.0, 100.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 54.0, 56.0, 55.0, 58.0, 55.0, 56.0, 59.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 56.0, 56.0, 55.0, 65.0, 55.0, 55.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 98.0, 90.0, 96.0, 95.0, 90.0, 88.0, 88.0, 125.0, 86.0], "value": 94.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 138.0, 147.0, 136.0, 131.0, 129.0, 135.0, 135.0, 159.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 189.0, 201.0, 193.0, 192.0, 196.0, 202.0, 193.0, 198.0, 191.0], "value": 194.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 73.0, 72.0, 73.0, 75.0, 75.0, 74.0, 71.0], "value": 73.6, "unit": "score"}]}]} 14:13:41 INFO - Return code: 0 14:13:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:13:41 INFO - # TBPL SUCCESS # 14:13:41 INFO - Running post-action listener: _resource_record_post_action 14:13:41 INFO - [mozharness: 2017-05-30 21:13:41.827204Z] Finished run-tests step (success) 14:13:41 INFO - Running post-run listener: _resource_record_post_run 14:13:41 INFO - Total resource usage - Wall time: 1259s; CPU: 13.0%; Read bytes: 0; Write bytes: 409120768; Read time: 0; Write time: 299256 14:13:41 INFO - TinderboxPrint: CPU usage
12.7% 14:13:41 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:13:41 INFO - TinderboxPrint: I/O write bytes / time
409,120,768 / 299,256 14:13:41 INFO - TinderboxPrint: CPU idle
8,773.5 (87.3%) 14:13:41 INFO - TinderboxPrint: CPU user
1,223.6 (12.2%) 14:13:41 INFO - TinderboxPrint: Swap in / out
0 / 0 14:13:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 95457280; Read time: 0; Write time: 78176 14:13:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:13:41 INFO - run-tests - Wall time: 1243s; CPU: 13.0%; Read bytes: 0; Write bytes: 313663488; Read time: 0; Write time: 221080 14:13:42 INFO - Running post-run listener: _upload_blobber_files 14:13:42 INFO - Blob upload gear active. 14:13:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:13:42 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 14:13:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:13:42 INFO - (blobuploader) - INFO - Open directory for files ... 14:13:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:13:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:13:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:43 INFO - (blobuploader) - INFO - Done attempting. 14:13:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:13:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:13:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:47 INFO - (blobuploader) - INFO - Done attempting. 14:13:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:13:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:13:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:48 INFO - (blobuploader) - INFO - Done attempting. 14:13:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:13:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:13:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:49 INFO - (blobuploader) - INFO - Done attempting. 14:13:49 INFO - (blobuploader) - INFO - Iteration through files over. 14:13:49 INFO - Return code: 0 14:13:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:13:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:13:49 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e37e9731715b30c30ecca103ce3d6e189dea46db29fff4b3f048ec5220c575f20414a707a104491ca14a335661b716610e0f03a52c2b1d6a28b90832f9f2323", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e3ce1fa80edfbc4ca78ec324509cd6ca10ff473def7679654718a0e4dfe24399080c8254ec7929f157bdd429bc3b9521ca575898575cbd1f60bb410977e9f68", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a444fa1b1aec38eae6d947c7f8d5a7ceae8b9860647d66389b7666d644c8e814de7a95dfa29e94ca203e3d4b9d03cbf541ff73e1377dd3598e520f43d1bcdf52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/586c9945cb72629d5adcc2d361e7562a19a3494f60aa28bb8fb0c7d450b93e602da735cc5a69dfe3d18e106c3c8a6f7684a169115f5d192df4211f6ef7010cec"} 14:13:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:13:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:13:49 INFO - Contents: 14:13:49 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e37e9731715b30c30ecca103ce3d6e189dea46db29fff4b3f048ec5220c575f20414a707a104491ca14a335661b716610e0f03a52c2b1d6a28b90832f9f2323", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e3ce1fa80edfbc4ca78ec324509cd6ca10ff473def7679654718a0e4dfe24399080c8254ec7929f157bdd429bc3b9521ca575898575cbd1f60bb410977e9f68", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a444fa1b1aec38eae6d947c7f8d5a7ceae8b9860647d66389b7666d644c8e814de7a95dfa29e94ca203e3d4b9d03cbf541ff73e1377dd3598e520f43d1bcdf52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/586c9945cb72629d5adcc2d361e7562a19a3494f60aa28bb8fb0c7d450b93e602da735cc5a69dfe3d18e106c3c8a6f7684a169115f5d192df4211f6ef7010cec"} 14:13:49 INFO - Running post-run listener: copy_logs_to_upload_dir 14:13:49 INFO - Copying logs to upload dir... 14:13:49 INFO - mkdir: /builds/slave/test/build/upload/logs 14:13:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1318.654724 ========= master_lag: -0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-30 14:13:48.524791) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 14:13:48.532431) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e37e9731715b30c30ecca103ce3d6e189dea46db29fff4b3f048ec5220c575f20414a707a104491ca14a335661b716610e0f03a52c2b1d6a28b90832f9f2323", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e3ce1fa80edfbc4ca78ec324509cd6ca10ff473def7679654718a0e4dfe24399080c8254ec7929f157bdd429bc3b9521ca575898575cbd1f60bb410977e9f68", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a444fa1b1aec38eae6d947c7f8d5a7ceae8b9860647d66389b7666d644c8e814de7a95dfa29e94ca203e3d4b9d03cbf541ff73e1377dd3598e520f43d1bcdf52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/586c9945cb72629d5adcc2d361e7562a19a3494f60aa28bb8fb0c7d450b93e602da735cc5a69dfe3d18e106c3c8a6f7684a169115f5d192df4211f6ef7010cec"} build_url:https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/Sgsv6Sb0TwSj4Up3Sb4Rwg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e37e9731715b30c30ecca103ce3d6e189dea46db29fff4b3f048ec5220c575f20414a707a104491ca14a335661b716610e0f03a52c2b1d6a28b90832f9f2323", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e3ce1fa80edfbc4ca78ec324509cd6ca10ff473def7679654718a0e4dfe24399080c8254ec7929f157bdd429bc3b9521ca575898575cbd1f60bb410977e9f68", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a444fa1b1aec38eae6d947c7f8d5a7ceae8b9860647d66389b7666d644c8e814de7a95dfa29e94ca203e3d4b9d03cbf541ff73e1377dd3598e520f43d1bcdf52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/586c9945cb72629d5adcc2d361e7562a19a3494f60aa28bb8fb0c7d450b93e602da735cc5a69dfe3d18e106c3c8a6f7684a169115f5d192df4211f6ef7010cec"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 14:13:48.559263) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 14:13:48.559558) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1496173041.377284-55966248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 14:13:48.691005) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 14:13:48.691306) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 14:13:48.691575) ========= ========= Total master_lag: 0.13 =========