builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-085 starttime: 1496679765.65 results: success (0) revision: 83a7d3a213da7ea0042d806082853540d13a6fb8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:45.649835) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:45.650275) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:45.650544) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:45.666083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:45.666400) ========= 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=5c37b704b588aaa989324530000001d0-1496679765.294408-569337594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-05 09:22:45-- 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% 42.3M=0s 2017-06-05 09:22:46 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:45.808890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:45.812242) ========= 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=5c37b704b588aaa989324530000001d0-1496679765.294408-569337594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020065 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:45.861839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:45.865192) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 83a7d3a213da7ea0042d806082853540d13a6fb8 --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 83a7d3a213da7ea0042d806082853540d13a6fb8 --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=5c37b704b588aaa989324530000001d0-1496679765.294408-569337594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-05 09:22:46,225 truncating revision to first 12 chars 2017-06-05 09:22:46,225 Setting DEBUG logging. 2017-06-05 09:22:46,225 attempt 1/10 2017-06-05 09:22:46,225 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/83a7d3a213da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-05 09:22:46,528 unpacking tar archive at: mozilla-central-83a7d3a213da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.608740 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:46.485955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:46.489296) ========= script_repo_revision: 83a7d3a213da7ea0042d806082853540d13a6fb8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:46.489653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:46.489912) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 09:22:46.500056) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-06-05 09:22:46.500346) ========= /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=5c37b704b588aaa989324530000001d0-1496679765.294408-569337594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:22:46 INFO - MultiFileLogger online at 20170605 09:22:46 in /builds/slave/test 09:22:46 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 09:22:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:22:46 INFO - {'append_to_log': False, 09:22:46 INFO - 'base_work_dir': '/builds/slave/test', 09:22:46 INFO - 'blob_upload_branch': 'Firefox', 09:22:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:22:46 INFO - 'branch': 'Firefox', 09:22:46 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:46 INFO - 'config_files': ('talos/linux_config.py',), 09:22:46 INFO - 'default_actions': ('clobber', 09:22:46 INFO - 'read-buildbot-config', 09:22:46 INFO - 'download-and-extract', 09:22:46 INFO - 'populate-webroot', 09:22:46 INFO - 'create-virtualenv', 09:22:46 INFO - 'install', 09:22:46 INFO - 'setup-mitmproxy', 09:22:46 INFO - 'run-tests'), 09:22:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:46 INFO - 'download_minidump_stackwalk': True, 09:22:46 INFO - 'download_symbols': 'ondemand', 09:22:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:46 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:46 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:46 INFO - 'gecko_profile': False, 09:22:46 INFO - 'gecko_profile_interval': 0, 09:22:46 INFO - 'installer_path': 'installer.exe', 09:22:46 INFO - 'log_level': 'info', 09:22:46 INFO - 'log_name': 'talos', 09:22:46 INFO - 'log_to_console': True, 09:22:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:22:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:22:46 INFO - 'opt_config_files': (), 09:22:46 INFO - 'pip_index': False, 09:22:46 INFO - 'suite': 'dromaeojs-e10s', 09:22:46 INFO - 'system_bits': '32', 09:22:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:46 INFO - 'title': 'talos-linux64-ix-085', 09:22:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:46 INFO - 'use_talos_json': True, 09:22:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:22:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:46 INFO - 'work_dir': 'build'} 09:22:46 INFO - [mozharness: 2017-06-05 16:22:46.954500Z] Running clobber step. 09:22:46 INFO - Running pre-action listener: _resource_record_pre_action 09:22:46 INFO - Running main action method: clobber 09:22:46 INFO - rmtree: /builds/slave/test/build 09:22:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:22:47 INFO - Running post-action listener: _resource_record_post_action 09:22:47 INFO - [mozharness: 2017-06-05 16:22:47.988568Z] Finished clobber step (success) 09:22:47 INFO - [mozharness: 2017-06-05 16:22:47.988669Z] Running read-buildbot-config step. 09:22:47 INFO - Running pre-action listener: _resource_record_pre_action 09:22:47 INFO - Running main action method: read_buildbot_config 09:22:47 INFO - Using buildbot properties: 09:22:47 INFO - { 09:22:47 INFO - "project": "", 09:22:47 INFO - "product": "firefox", 09:22:47 INFO - "who": "ffxbld@noreply.mozilla.org", 09:22:47 INFO - "installer_path": "public/build/target.tar.bz2", 09:22:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 09:22:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:22:47 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 09:22:47 INFO - "stage_platform": "linux64-stylosequential", 09:22:47 INFO - "basedir": "/builds/slave/test", 09:22:47 INFO - "buildnumber": 50, 09:22:47 INFO - "platform": "ubuntu64_hw_styloseq", 09:22:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:22:47 INFO - "slavebuilddir": "test", 09:22:47 INFO - "taskId": "cT7a9sVTR06TPwnDNthFYg", 09:22:47 INFO - "branch": "mozilla-central", 09:22:47 INFO - "script_repo_revision": "production", 09:22:47 INFO - "revision": "83a7d3a213da7ea0042d806082853540d13a6fb8", 09:22:47 INFO - "slavename": "talos-linux64-ix-085", 09:22:47 INFO - "repo_path": "mozilla-central" 09:22:47 INFO - } 09:22:47 INFO - Finding installer, test and symbols from parent task. 09:22:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cT7a9sVTR06TPwnDNthFYg'}, attempt #1 09:22:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cT7a9sVTR06TPwnDNthFYg'}, attempt #1 09:22:48 INFO - Task dependencies: EaTerL3kThu0D8gfNguL3Q 09:22:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q'}, attempt #1 09:22:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.tar.bz2 09:22:49 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/test_packages.json 09:22:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.crashreporter-symbols.zip 09:22:49 INFO - Running post-action listener: _resource_record_post_action 09:22:49 INFO - [mozharness: 2017-06-05 16:22:49.361496Z] Finished read-buildbot-config step (success) 09:22:49 INFO - [mozharness: 2017-06-05 16:22:49.361719Z] Running download-and-extract step. 09:22:49 INFO - Running pre-action listener: _resource_record_pre_action 09:22:49 INFO - Running main action method: download_and_extract 09:22:49 INFO - mkdir: /builds/slave/test/build/tests 09:22:49 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')]} 09:22:49 INFO - trying https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.test_packages.json 09:22:49 INFO - Downloading https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:22:49 INFO - Downloaded 989 bytes. 09:22:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:22:49 INFO - Using the following test package requirements: 09:22:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:22:49 INFO - u'common': [u'target.common.tests.zip'], 09:22:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:22:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:22:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:22:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:22:49 INFO - u'mozbase': [u'target.common.tests.zip'], 09:22:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:22:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:22:49 INFO - u'web-platform': [u'target.common.tests.zip', 09:22:49 INFO - u'target.web-platform.tests.tar.gz'], 09:22:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:22:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:22:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.common.tests.zip 09:22:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:22:49 INFO - Fetch https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.common.tests.zip into memory 09:22:51 INFO - Content-Length response header: 65102999 09:22:51 INFO - Bytes received: 65102999 09:23:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:23:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.common.tests.zip 09:23:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:23:01 INFO - Fetch https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.common.tests.zip into memory 09:23:03 INFO - Content-Length response header: 65102999 09:23:03 INFO - Bytes received: 65102999 09:23:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.talos.tests.zip 09:23:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:23:14 INFO - Fetch https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.talos.tests.zip into memory 09:23:15 INFO - Content-Length response header: 14447425 09:23:15 INFO - Bytes received: 14447425 09:23:15 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')]} 09:23:15 INFO - trying https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.tar.bz2 09:23:15 INFO - Downloading https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:23:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:23:17 INFO - Downloaded 60480381 bytes. 09:23:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.tar.bz2 09:23:17 INFO - mkdir: /builds/slave/test/properties 09:23:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:17 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:17 INFO - Contents: 09:23:17 INFO - build_url:https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.tar.bz2 09:23:17 INFO - Running post-action listener: _resource_record_post_action 09:23:17 INFO - Running post-action listener: set_extra_try_arguments 09:23:17 INFO - [mozharness: 2017-06-05 16:23:17.177545Z] Finished download-and-extract step (success) 09:23:17 INFO - [mozharness: 2017-06-05 16:23:17.177642Z] Running populate-webroot step. 09:23:17 INFO - Running pre-action listener: _resource_record_pre_action 09:23:17 INFO - Running main action method: populate_webroot 09:23:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:17 INFO - '--tppagecycles', 09:23:17 INFO - '7'], 09:23:17 INFO - 'tests': ['tsvgm']}}, 09:23:17 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:23:17 INFO - 'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:23:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:23:17 INFO - 'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['damp', 'tps']}, 09:23:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:23:17 INFO - 'tests': ['damp', 'tps']}, 09:23:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['dromaeo_dom']}, 09:23:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:23:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:23:17 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:23:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:23:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['a11yr', 09:23:17 INFO - 'ts_paint', 09:23:17 INFO - 'tpaint', 09:23:17 INFO - 'sessionrestore', 09:23:17 INFO - 'sessionrestore_no_auto_restore', 09:23:17 INFO - 'tabpaint']}, 09:23:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:17 INFO - 'ts_paint', 09:23:17 INFO - 'tpaint', 09:23:17 INFO - 'sessionrestore', 09:23:17 INFO - 'sessionrestore_no_auto_restore', 09:23:17 INFO - 'tabpaint']}, 09:23:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:17 INFO - 'ts_paint', 09:23:17 INFO - 'tpaint', 09:23:17 INFO - 'sessionrestore', 09:23:17 INFO - 'sessionrestore_no_auto_restore', 09:23:17 INFO - 'tabpaint']}, 09:23:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:17 INFO - 'ts_paint', 09:23:17 INFO - 'tpaint', 09:23:17 INFO - 'sessionrestore', 09:23:17 INFO - 'sessionrestore_no_auto_restore', 09:23:17 INFO - 'tabpaint']}, 09:23:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['a11yr', 09:23:17 INFO - 'ts_paint', 09:23:17 INFO - 'tpaint', 09:23:17 INFO - 'sessionrestore', 09:23:17 INFO - 'sessionrestore_no_auto_restore', 09:23:17 INFO - 'tabpaint']}, 09:23:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['a11yr', 09:23:17 INFO - 'ts_paint', 09:23:17 INFO - 'tpaint', 09:23:17 INFO - 'sessionrestore', 09:23:17 INFO - 'sessionrestore_no_auto_restore', 09:23:17 INFO - 'tabpaint']}, 09:23:17 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:23:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:23:17 INFO - 'bloom_basic_ref']}, 09:23:17 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:23:17 INFO - 'talos_options': ['--mitmproxy', 09:23:17 INFO - 'mitmproxy-recording-1.mp', 09:23:17 INFO - '--firstNonBlankPaint'], 09:23:17 INFO - 'tests': ['Quantum_1']}, 09:23:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['tsvgx', 09:23:17 INFO - 'tsvgr_opacity', 09:23:17 INFO - 'tart', 09:23:17 INFO - 'tscrollx', 09:23:17 INFO - 'cart', 09:23:17 INFO - 'tsvg_static']}, 09:23:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:17 INFO - 'tsvgr_opacity', 09:23:17 INFO - 'tart', 09:23:17 INFO - 'tscrollx', 09:23:17 INFO - 'cart', 09:23:17 INFO - 'tsvg_static']}, 09:23:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:23:17 INFO - 'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['tp5o']}, 09:23:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:23:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:23:17 INFO - 'talos_options': ['--disable-e10s', 09:23:17 INFO - '--xperf_path', 09:23:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:17 INFO - 'tests': ['tp5n']}, 09:23:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:23:17 INFO - 'talos_options': ['--xperf_path', 09:23:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:17 INFO - 'tests': ['tp5n']}}, 09:23:17 INFO - 'talos.zip': {'path': '', 09:23:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:17 INFO - Running post-action listener: _resource_record_post_action 09:23:17 INFO - [mozharness: 2017-06-05 16:23:17.192016Z] Finished populate-webroot step (success) 09:23:17 INFO - [mozharness: 2017-06-05 16:23:17.192106Z] Running create-virtualenv step. 09:23:17 INFO - Running pre-action listener: _resource_record_pre_action 09:23:17 INFO - Running main action method: create_virtualenv 09:23:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:17 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 09:23:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:17 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:23:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:17 INFO - Using real prefix '/usr' 09:23:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:17 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:19 INFO - Installing pip.................done. 09:23:19 INFO - Return code: 0 09:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:23:19 INFO - Reading from file tmpfile_stdout 09:23:19 INFO - Output received: 09:23:19 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) 09:23:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:19 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')]} 09:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:19 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')]} 09:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:20 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 0xee83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263840>, '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 0x1264740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264bd0>, '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': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', '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 09:23:20 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 09:23:20 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 09:23:20 INFO - Using env: {'DISPLAY': ':0', 09:23:20 INFO - 'HOME': '/home/cltbld', 09:23:20 INFO - 'LANG': 'en_US.UTF-8', 09:23:20 INFO - 'LANGUAGE': 'en_US:en', 09:23:20 INFO - 'LOGNAME': 'cltbld', 09:23:20 INFO - 'MAIL': '/var/mail/cltbld', 09:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:20 INFO - 'MOZ_NO_REMOTE': '1', 09:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:20 INFO - 'NO_EM_RESTART': '1', 09:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:20 INFO - 'PWD': '/builds/slave/test', 09:23:20 INFO - 'SHELL': '/bin/bash', 09:23:20 INFO - 'SHLVL': '1', 09:23:20 INFO - 'TERM': 'linux', 09:23:20 INFO - 'TMOUT': '86400', 09:23:20 INFO - 'USER': 'cltbld', 09:23:20 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', 09:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:20 INFO - '_': '/tools/buildbot/bin/python'} 09:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:20 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 09:23:20 INFO - Cleaning up... 09:23:20 INFO - Return code: 0 09:23:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:20 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')]} 09:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:20 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')]} 09:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:20 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 0xee83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263840>, '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 0x1264740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264bd0>, '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': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', '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 09:23:20 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 09:23:20 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 09:23:20 INFO - Using env: {'DISPLAY': ':0', 09:23:20 INFO - 'HOME': '/home/cltbld', 09:23:20 INFO - 'LANG': 'en_US.UTF-8', 09:23:20 INFO - 'LANGUAGE': 'en_US:en', 09:23:20 INFO - 'LOGNAME': 'cltbld', 09:23:20 INFO - 'MAIL': '/var/mail/cltbld', 09:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:20 INFO - 'MOZ_NO_REMOTE': '1', 09:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:20 INFO - 'NO_EM_RESTART': '1', 09:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:20 INFO - 'PWD': '/builds/slave/test', 09:23:20 INFO - 'SHELL': '/bin/bash', 09:23:20 INFO - 'SHLVL': '1', 09:23:20 INFO - 'TERM': 'linux', 09:23:20 INFO - 'TMOUT': '86400', 09:23:20 INFO - 'USER': 'cltbld', 09:23:20 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', 09:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:20 INFO - '_': '/tools/buildbot/bin/python'} 09:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:20 INFO - Downloading/unpacking psutil>=3.1.1 09:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:21 INFO - Installing collected packages: psutil 09:23:21 INFO - Running setup.py install for psutil 09:23:21 INFO - building 'psutil._psutil_linux' extension 09:23:21 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 09:23:21 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 09:23:21 INFO - building 'psutil._psutil_posix' extension 09:23:21 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 09:23:22 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 09:23:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:22 INFO - Successfully installed psutil 09:23:22 INFO - Cleaning up... 09:23:22 INFO - Return code: 0 09:23:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23: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')]} 09:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:22 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 0xee83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263840>, '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 0x1264740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264bd0>, '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': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', '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 09:23:22 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 09:23:22 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 09:23:22 INFO - Using env: {'DISPLAY': ':0', 09:23:22 INFO - 'HOME': '/home/cltbld', 09:23:22 INFO - 'LANG': 'en_US.UTF-8', 09:23:22 INFO - 'LANGUAGE': 'en_US:en', 09:23:22 INFO - 'LOGNAME': 'cltbld', 09:23:22 INFO - 'MAIL': '/var/mail/cltbld', 09:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:22 INFO - 'MOZ_NO_REMOTE': '1', 09:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:22 INFO - 'NO_EM_RESTART': '1', 09:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:22 INFO - 'PWD': '/builds/slave/test', 09:23:22 INFO - 'SHELL': '/bin/bash', 09:23:22 INFO - 'SHLVL': '1', 09:23:22 INFO - 'TERM': 'linux', 09:23:22 INFO - 'TMOUT': '86400', 09:23:22 INFO - 'USER': 'cltbld', 09:23:22 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', 09:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:22 INFO - '_': '/tools/buildbot/bin/python'} 09:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:23 INFO - Installing collected packages: mozsystemmonitor 09:23:23 INFO - Running setup.py install for mozsystemmonitor 09:23:23 INFO - Successfully installed mozsystemmonitor 09:23:23 INFO - Cleaning up... 09:23:23 INFO - Return code: 0 09:23:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:23 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')]} 09:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:23 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')]} 09:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:23 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 0xee83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263840>, '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 0x1264740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264bd0>, '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': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', '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 09:23:23 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 09:23:23 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 09:23:23 INFO - Using env: {'DISPLAY': ':0', 09:23:23 INFO - 'HOME': '/home/cltbld', 09:23:23 INFO - 'LANG': 'en_US.UTF-8', 09:23:23 INFO - 'LANGUAGE': 'en_US:en', 09:23:23 INFO - 'LOGNAME': 'cltbld', 09:23:23 INFO - 'MAIL': '/var/mail/cltbld', 09:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:23 INFO - 'MOZ_NO_REMOTE': '1', 09:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:23 INFO - 'NO_EM_RESTART': '1', 09:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:23 INFO - 'PWD': '/builds/slave/test', 09:23:23 INFO - 'SHELL': '/bin/bash', 09:23:23 INFO - 'SHLVL': '1', 09:23:23 INFO - 'TERM': 'linux', 09:23:23 INFO - 'TMOUT': '86400', 09:23:23 INFO - 'USER': 'cltbld', 09:23:23 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', 09:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:23 INFO - '_': '/tools/buildbot/bin/python'} 09:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:23 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:23:24 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 09:23:24 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 09:23:24 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 09:23:24 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 09:23:25 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:25 INFO - warning: no files found matching '*.txt' 09:23:25 INFO - no previously-included directories found matching 'build' 09:23:25 INFO - no previously-included directories found matching 'dist' 09:23:25 INFO - no previously-included directories found matching '.git*' 09:23:25 INFO - Installing collected packages: jsonschema, functools32 09:23:25 INFO - Running setup.py install for functools32 09:23:25 INFO - warning: no files found matching '*.txt' 09:23:25 INFO - no previously-included directories found matching 'build' 09:23:25 INFO - no previously-included directories found matching 'dist' 09:23:25 INFO - no previously-included directories found matching '.git*' 09:23:25 INFO - Successfully installed jsonschema functools32 09:23:25 INFO - Cleaning up... 09:23:25 INFO - Return code: 0 09:23:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:23:25 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')]} 09:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:25 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')]} 09:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xee83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263840>, '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 0x1264740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264bd0>, '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': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', '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 09:23:25 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 09:23:25 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 09:23:25 INFO - Using env: {'DISPLAY': ':0', 09:23:25 INFO - 'HOME': '/home/cltbld', 09:23:25 INFO - 'LANG': 'en_US.UTF-8', 09:23:25 INFO - 'LANGUAGE': 'en_US:en', 09:23:25 INFO - 'LOGNAME': 'cltbld', 09:23:25 INFO - 'MAIL': '/var/mail/cltbld', 09:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:25 INFO - 'MOZ_NO_REMOTE': '1', 09:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:25 INFO - 'NO_EM_RESTART': '1', 09:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:25 INFO - 'PWD': '/builds/slave/test', 09:23:25 INFO - 'SHELL': '/bin/bash', 09:23:25 INFO - 'SHLVL': '1', 09:23:25 INFO - 'TERM': 'linux', 09:23:25 INFO - 'TMOUT': '86400', 09:23:25 INFO - 'USER': 'cltbld', 09:23:25 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', 09:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:25 INFO - '_': '/tools/buildbot/bin/python'} 09:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:23:25 INFO - Cleaning up... 09:23:25 INFO - Return code: 0 09:23:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23:25 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')]} 09:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:25 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')]} 09:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xee83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263840>, '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 0x1264740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264bd0>, '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': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', '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 09:23:25 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 09:23:25 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 09:23:25 INFO - Using env: {'DISPLAY': ':0', 09:23:25 INFO - 'HOME': '/home/cltbld', 09:23:25 INFO - 'LANG': 'en_US.UTF-8', 09:23:25 INFO - 'LANGUAGE': 'en_US:en', 09:23:25 INFO - 'LOGNAME': 'cltbld', 09:23:25 INFO - 'MAIL': '/var/mail/cltbld', 09:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:25 INFO - 'MOZ_NO_REMOTE': '1', 09:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:25 INFO - 'NO_EM_RESTART': '1', 09:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:25 INFO - 'PWD': '/builds/slave/test', 09:23:25 INFO - 'SHELL': '/bin/bash', 09:23:25 INFO - 'SHLVL': '1', 09:23:25 INFO - 'TERM': 'linux', 09:23:25 INFO - 'TMOUT': '86400', 09:23:25 INFO - 'USER': 'cltbld', 09:23:25 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', 09:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:25 INFO - '_': '/tools/buildbot/bin/python'} 09:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:25 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:25 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 09:23:25 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 09:23:25 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 09:23:25 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 09:23:27 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23:27 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 09:23:27 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 09:23:27 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 09:23:27 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 09:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:23:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23: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 09:23: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 09:23: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 09:23: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 09:23:28 INFO - Downloading docopt-0.6.1.tar.gz 09:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:23:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:23:28 INFO - Running setup.py install for blobuploader 09:23:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:23:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:23:28 INFO - Running setup.py install for requests 09:23:28 INFO - Running setup.py install for docopt 09:23:28 INFO - Successfully installed blobuploader requests docopt 09:23:28 INFO - Cleaning up... 09:23:29 INFO - Return code: 0 09:23:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23: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')]} 09:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:29 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 0xee83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263840>, '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 0x1264740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264bd0>, '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': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', '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 09:23:29 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 09:23:29 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 09:23:29 INFO - Using env: {'DISPLAY': ':0', 09:23:29 INFO - 'HOME': '/home/cltbld', 09:23:29 INFO - 'LANG': 'en_US.UTF-8', 09:23:29 INFO - 'LANGUAGE': 'en_US:en', 09:23:29 INFO - 'LOGNAME': 'cltbld', 09:23:29 INFO - 'MAIL': '/var/mail/cltbld', 09:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:29 INFO - 'MOZ_NO_REMOTE': '1', 09:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:29 INFO - 'NO_EM_RESTART': '1', 09:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:29 INFO - 'PWD': '/builds/slave/test', 09:23:29 INFO - 'SHELL': '/bin/bash', 09:23:29 INFO - 'SHLVL': '1', 09:23:29 INFO - 'TERM': 'linux', 09:23:29 INFO - 'TMOUT': '86400', 09:23:29 INFO - 'USER': 'cltbld', 09:23:29 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', 09:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:29 INFO - '_': '/tools/buildbot/bin/python'} 09:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:29 INFO - Running setup.py (path:/tmp/pip-bTffG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:29 INFO - Running setup.py (path:/tmp/pip-_G_HZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:29 INFO - Running setup.py (path:/tmp/pip-iE6hoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:29 INFO - Running setup.py (path:/tmp/pip-rCHm_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:29 INFO - Running setup.py (path:/tmp/pip-g4CFes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:29 INFO - Running setup.py (path:/tmp/pip-OZBMIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:29 INFO - Running setup.py (path:/tmp/pip-wS5dTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:29 INFO - Running setup.py (path:/tmp/pip-gv_KEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:29 INFO - Running setup.py (path:/tmp/pip-WwKugX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:29 INFO - Running setup.py (path:/tmp/pip-UDmT9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:29 INFO - Running setup.py (path:/tmp/pip-SZ_Fjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:30 INFO - Running setup.py (path:/tmp/pip-42tH1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:30 INFO - Running setup.py (path:/tmp/pip-qhFQ1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:30 INFO - Running setup.py (path:/tmp/pip-1qjETD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:30 INFO - Running setup.py (path:/tmp/pip-124gXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:30 INFO - Running setup.py (path:/tmp/pip-4IVeDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:30 INFO - Running setup.py (path:/tmp/pip-UmM026-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:30 INFO - Running setup.py install for manifestparser 09:23:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:23:30 INFO - Running setup.py install for mozcrash 09:23:30 INFO - Running setup.py install for mozdebug 09:23:30 INFO - Running setup.py install for mozdevice 09:23:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:23:30 INFO - Running setup.py install for mozfile 09:23:30 INFO - Running setup.py install for mozhttpd 09:23:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Running setup.py install for mozinfo 09:23:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Running setup.py install for mozInstall 09:23:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Running setup.py install for mozleak 09:23:31 INFO - Running setup.py install for mozlog 09:23:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Running setup.py install for moznetwork 09:23:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Running setup.py install for mozprocess 09:23:31 INFO - Running setup.py install for mozprofile 09:23:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Running setup.py install for mozrunner 09:23:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:23:31 INFO - Running setup.py install for mozscreenshot 09:23:31 INFO - Running setup.py install for moztest 09:23:32 INFO - Running setup.py install for mozversion 09:23:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:23:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:32 INFO - Cleaning up... 09:23:32 INFO - Return code: 0 09:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:32 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')]} 09:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:32 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')]} 09:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:32 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 0xee83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263840>, '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 0x1264740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264bd0>, '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': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', '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 09:23:32 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 09:23:32 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 09:23:32 INFO - Using env: {'DISPLAY': ':0', 09:23:32 INFO - 'HOME': '/home/cltbld', 09:23:32 INFO - 'LANG': 'en_US.UTF-8', 09:23:32 INFO - 'LANGUAGE': 'en_US:en', 09:23:32 INFO - 'LOGNAME': 'cltbld', 09:23:32 INFO - 'MAIL': '/var/mail/cltbld', 09:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:32 INFO - 'MOZ_NO_REMOTE': '1', 09:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:32 INFO - 'NO_EM_RESTART': '1', 09:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:32 INFO - 'PWD': '/builds/slave/test', 09:23:32 INFO - 'SHELL': '/bin/bash', 09:23:32 INFO - 'SHLVL': '1', 09:23:32 INFO - 'TERM': 'linux', 09:23:32 INFO - 'TMOUT': '86400', 09:23:32 INFO - 'USER': 'cltbld', 09:23:32 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', 09:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:32 INFO - '_': '/tools/buildbot/bin/python'} 09:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:32 INFO - Running setup.py (path:/tmp/pip-RrKxF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:32 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)) 09:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:32 INFO - Running setup.py (path:/tmp/pip-vmFgtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:32 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)) 09:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:32 INFO - Running setup.py (path:/tmp/pip-N35Nzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:32 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)) 09:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:32 INFO - Running setup.py (path:/tmp/pip-YPa6ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:32 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)) 09:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:32 INFO - Running setup.py (path:/tmp/pip-IqWxwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:32 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)) 09:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:32 INFO - Running setup.py (path:/tmp/pip-q2B7UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:32 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)) 09:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:32 INFO - Running setup.py (path:/tmp/pip-rC7EnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:32 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)) 09:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:32 INFO - Running setup.py (path:/tmp/pip-ozu66W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:32 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)) 09:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:32 INFO - Running setup.py (path:/tmp/pip-hjW7c4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:33 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)) 09:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:33 INFO - Running setup.py (path:/tmp/pip-1oTGX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:33 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)) 09:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:33 INFO - Running setup.py (path:/tmp/pip-tyGjaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:33 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)) 09:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:33 INFO - Running setup.py (path:/tmp/pip-l9hisU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:33 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)) 09:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:33 INFO - Running setup.py (path:/tmp/pip-zgX3CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:33 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)) 09:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:33 INFO - Running setup.py (path:/tmp/pip-nzYhGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:33 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)) 09:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:33 INFO - Running setup.py (path:/tmp/pip-UjQ71t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:33 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)) 09:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:33 INFO - Running setup.py (path:/tmp/pip-xgZ3Gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:33 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)) 09:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:33 INFO - Running setup.py (path:/tmp/pip-S8k_3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:33 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)) 09:23:33 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)) 09:23:33 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)) 09:23:33 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)) 09:23:33 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)) 09:23:33 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)) 09:23:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23: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 09:23: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 09:23: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 09:23: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 09:23:34 INFO - Downloading blessings-1.6.tar.gz 09:23:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:34 INFO - Installing collected packages: blessings 09:23:34 INFO - Running setup.py install for blessings 09:23:34 INFO - Successfully installed blessings 09:23:34 INFO - Cleaning up... 09:23:34 INFO - Return code: 0 09:23:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:23:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:35 INFO - Reading from file tmpfile_stdout 09:23:35 INFO - Current package versions: 09:23:35 INFO - argparse == 1.2.1 09:23:35 INFO - blessings == 1.6 09:23:35 INFO - blobuploader == 1.2.4 09:23:35 INFO - docopt == 0.6.1 09:23:35 INFO - functools32 == 3.2.3-2 09:23:35 INFO - jsonschema == 2.5.1 09:23:35 INFO - manifestparser == 1.1 09:23:35 INFO - mozInstall == 1.12 09:23:35 INFO - mozcrash == 1.0 09:23:35 INFO - mozdebug == 0.1 09:23:35 INFO - mozdevice == 0.51 09:23:35 INFO - mozfile == 1.2 09:23:35 INFO - mozhttpd == 0.7 09:23:35 INFO - mozinfo == 0.9 09:23:35 INFO - mozleak == 0.1 09:23:35 INFO - mozlog == 3.4 09:23:35 INFO - moznetwork == 0.27 09:23:35 INFO - mozprocess == 0.25 09:23:35 INFO - mozprofile == 0.28 09:23:35 INFO - mozrunner == 6.13 09:23:35 INFO - mozscreenshot == 0.1 09:23:35 INFO - mozsystemmonitor == 0.3 09:23:35 INFO - moztest == 0.8 09:23:35 INFO - mozversion == 1.4 09:23:35 INFO - psutil == 3.1.1 09:23:35 INFO - requests == 1.2.3 09:23:35 INFO - wsgiref == 0.1.2 09:23:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:35 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')]} 09:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:35 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')]} 09:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:35 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 0xee83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263840>, '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 0x1264740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264bd0>, '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': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', '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 09:23:35 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 09:23:35 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 09:23:35 INFO - Using env: {'DISPLAY': ':0', 09:23:35 INFO - 'HOME': '/home/cltbld', 09:23:35 INFO - 'LANG': 'en_US.UTF-8', 09:23:35 INFO - 'LANGUAGE': 'en_US:en', 09:23:35 INFO - 'LOGNAME': 'cltbld', 09:23:35 INFO - 'MAIL': '/var/mail/cltbld', 09:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:35 INFO - 'MOZ_NO_REMOTE': '1', 09:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:35 INFO - 'NO_EM_RESTART': '1', 09:23:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:35 INFO - 'PWD': '/builds/slave/test', 09:23:35 INFO - 'SHELL': '/bin/bash', 09:23:35 INFO - 'SHLVL': '1', 09:23:35 INFO - 'TERM': 'linux', 09:23:35 INFO - 'TMOUT': '86400', 09:23:35 INFO - 'USER': 'cltbld', 09:23:35 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', 09:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:35 INFO - '_': '/tools/buildbot/bin/python'} 09:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:35 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)) 09:23:35 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)) 09:23:35 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)) 09:23:35 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)) 09:23:35 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)) 09:23:35 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)) 09:23:35 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)) 09:23:35 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)) 09:23:35 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)) 09:23:35 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:23:35 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 09:23:35 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 09:23:35 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 09:23:35 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 09:23:36 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:23:36 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)) 09:23:36 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)) 09:23:36 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)) 09:23:36 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)) 09:23:36 INFO - Installing collected packages: marionette-driver 09:23:36 INFO - Running setup.py install for marionette-driver 09:23:36 INFO - Successfully installed marionette-driver 09:23:36 INFO - Cleaning up... 09:23:36 INFO - Return code: 0 09:23:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:23:36 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')]} 09:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:36 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')]} 09:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:36 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 0xee83b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1263840>, '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 0x1264740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264bd0>, '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': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', '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 09:23:36 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 09:23:36 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 09:23:36 INFO - Using env: {'DISPLAY': ':0', 09:23:36 INFO - 'HOME': '/home/cltbld', 09:23:36 INFO - 'LANG': 'en_US.UTF-8', 09:23:36 INFO - 'LANGUAGE': 'en_US:en', 09:23:36 INFO - 'LOGNAME': 'cltbld', 09:23:36 INFO - 'MAIL': '/var/mail/cltbld', 09:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:36 INFO - 'MOZ_NO_REMOTE': '1', 09:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:36 INFO - 'NO_EM_RESTART': '1', 09:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:36 INFO - 'PWD': '/builds/slave/test', 09:23:36 INFO - 'SHELL': '/bin/bash', 09:23:36 INFO - 'SHLVL': '1', 09:23:36 INFO - 'TERM': 'linux', 09:23:36 INFO - 'TMOUT': '86400', 09:23:36 INFO - 'USER': 'cltbld', 09:23:36 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', 09:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:36 INFO - '_': '/tools/buildbot/bin/python'} 09:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:23:36 INFO - Cleaning up... 09:23:36 INFO - Return code: 0 09:23:36 INFO - Running post-action listener: _resource_record_post_action 09:23:36 INFO - Running post-action listener: _start_resource_monitoring 09:23:37 INFO - Starting resource monitoring. 09:23:37 INFO - [mozharness: 2017-06-05 16:23:37.017100Z] Finished create-virtualenv step (success) 09:23:37 INFO - [mozharness: 2017-06-05 16:23:37.017611Z] Running install step. 09:23:37 INFO - Running pre-action listener: _resource_record_pre_action 09:23:37 INFO - Running main action method: install 09:23:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:37 INFO - Reading from file tmpfile_stdout 09:23:37 INFO - Detecting whether we're running mozinstall >=1.0... 09:23:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:23:37 INFO - Reading from file tmpfile_stdout 09:23:37 INFO - Output received: 09:23:37 INFO - Usage: mozinstall [options] installer 09:23:37 INFO - Options: 09:23:37 INFO - -h, --help show this help message and exit 09:23:37 INFO - -d DEST, --destination=DEST 09:23:37 INFO - Directory to install application into. [default: 09:23:37 INFO - "/builds/slave/test"] 09:23:37 INFO - --app=APP Application being installed. [default: firefox] 09:23:37 INFO - mkdir: /builds/slave/test/build/application 09:23:37 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'] 09:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:23:54 INFO - Reading from file tmpfile_stdout 09:23:54 INFO - Output received: 09:23:54 INFO - /builds/slave/test/build/application/firefox/firefox 09:23:54 INFO - Running post-action listener: _resource_record_post_action 09:23:54 INFO - [mozharness: 2017-06-05 16:23:54.757832Z] Finished install step (success) 09:23:54 INFO - [mozharness: 2017-06-05 16:23:54.758179Z] Running setup-mitmproxy step. 09:23:54 INFO - Running pre-action listener: _resource_record_pre_action 09:23:54 INFO - Running main action method: setup_mitmproxy 09:23:54 INFO - Skipping: mitmproxy is not required 09:23:54 INFO - Running post-action listener: _resource_record_post_action 09:23:54 INFO - [mozharness: 2017-06-05 16:23:54.759320Z] Finished setup-mitmproxy step (success) 09:23:54 INFO - [mozharness: 2017-06-05 16:23:54.759541Z] Running run-tests step. 09:23:54 INFO - Running pre-action listener: _resource_record_pre_action 09:23:54 INFO - Running main action method: run_tests 09:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:23:54 INFO - Python 2.7.3 09:23:54 INFO - Return code: 0 09:23:54 INFO - grabbing minidump binary from tooltool 09:23:54 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')]} 09:23:54 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 0x1263840>, '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 0x1264740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1264bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:23:54 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 09:23:54 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 09:23:54 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 09:23:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:23:54 INFO - Return code: 0 09:23:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:23:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:23:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:23:54 INFO - ENV: RUST_BACKTRACE is now 1 09:23:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:23:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:23:54 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/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 09:23:54 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/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-085 --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 09:23:54 INFO - Using env: {'DISPLAY': ':0', 09:23:54 INFO - 'HOME': '/home/cltbld', 09:23:54 INFO - 'LANG': 'en_US.UTF-8', 09:23:54 INFO - 'LANGUAGE': 'en_US:en', 09:23:54 INFO - 'LOGNAME': 'cltbld', 09:23:54 INFO - 'MAIL': '/var/mail/cltbld', 09:23:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:23:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:54 INFO - 'MOZ_NO_REMOTE': '1', 09:23:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:54 INFO - 'NO_EM_RESTART': '1', 09:23:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:54 INFO - 'PWD': '/builds/slave/test', 09:23:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:23:54 INFO - 'RUST_BACKTRACE': '1', 09:23:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:23:54 INFO - 'SHELL': '/bin/bash', 09:23:54 INFO - 'SHLVL': '1', 09:23:54 INFO - 'TERM': 'linux', 09:23:54 INFO - 'TMOUT': '86400', 09:23:54 INFO - 'USER': 'cltbld', 09:23:54 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1496679765.294408-569337594', 09:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:54 INFO - '_': '/tools/buildbot/bin/python'} 09:23:54 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/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 09:23:55 INFO - mozversion application_buildid: 20170605153956 09:23:55 INFO - mozversion application_changeset: 83a7d3a213da7ea0042d806082853540d13a6fb8 09:23:55 INFO - mozversion application_display_name: Nightly 09:23:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:23:55 INFO - mozversion application_name: Firefox 09:23:55 INFO - mozversion application_remotingname: firefox 09:23:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:23:55 INFO - mozversion application_vendor: Mozilla 09:23:55 INFO - mozversion application_version: 55.0a1 09:23:55 INFO - mozversion platform_buildid: 20170605153956 09:23:55 INFO - mozversion platform_changeset: 83a7d3a213da7ea0042d806082853540d13a6fb8 09:23:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:23:55 INFO - mozversion platform_version: 55.0a1 09:23:55 INFO - using testdate: 1496679835 09:23:55 INFO - actual date: 1496679835 09:23:55 INFO - starting webserver on 'localhost:57502' 09:23:55 INFO - SUITE-START | Running 2 tests 09:23:55 INFO - TEST-START | dromaeo_css 09:23:55 INFO - operating with platform_type : linux_ 09:23:55 INFO - Initialising browser for dromaeo_css test... 09:23:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57502/getInfo.html -profile /tmp/tmpF9sg9p/profile 09:23:55 INFO - TEST-INFO | started process 8489 (/builds/slave/test/build/application/firefox/firefox http://localhost:57502/getInfo.html) 09:24:30 INFO - TEST-INFO | 8489: killed by SIGTERM 09:24:30 INFO - Browser initialized. 09:24:30 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:30 INFO - TEST-INFO | started process 8715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF9sg9p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:42 INFO - PID 8715 | RSS: Main: 192188416 09:24:42 INFO - PID 8715 | 09:27:43 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:57502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57502/tests/dromaeo/cssquery-ext.html) 09:27:44 INFO - PID 8715 | RSS: Main: 186216448 09:27:44 INFO - PID 8715 | 09:30:46 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:57502/tests/dromaeo/cssquery-ext.html (next: http://localhost:57502/tests/dromaeo/cssquery-jquery.html) 09:30:47 INFO - PID 8715 | RSS: Main: 191643648 09:30:47 INFO - PID 8715 | 09:33:49 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:57502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57502/tests/dromaeo/cssquery-mootools.html) 09:33:49 INFO - PID 8715 | RSS: Main: 188973056 09:33:49 INFO - PID 8715 | 09:36:51 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:57502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57502/tests/dromaeo/cssquery-prototype.html) 09:36:52 INFO - PID 8715 | RSS: Main: 192688128 09:36:52 INFO - PID 8715 | 09:39:54 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:57502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57502/tests/dromaeo/cssquery-yui.html) 09:39:55 INFO - PID 8715 | RSS: Main: 193179648 09:39:55 INFO - PID 8715 | 09:42:57 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:57502/tests/dromaeo/cssquery-yui.html (next: http://localhost:57502/tests/dromaeo/cssquery-dojo.html) 09:42:57 INFO - PID 8715 | RSS: Main: 191098880 09:42:57 INFO - PID 8715 | 09:42:57 INFO - PID 8715 | __start_tp_report 09:42:57 INFO - PID 8715 | _x_x_mozilla_page_load 09:42:57 INFO - PID 8715 | _x_x_mozilla_page_load_details 09:42:57 INFO - PID 8715 | |i|pagename|runs| 09:42:57 INFO - PID 8715 | |0;dojo.html;3075.092847609955;3079.2917628945356;3096.31880986183;3119.3605310911257;3124.406362791068;5873.295204575446;5927.555433342501;5932.614380065293;5945.721669840988;6003.729832157558;5941.673207973559;5993.160957465958;6023.126646636246;6046.093086037096;6101.664408457533;5350.0904846176045;5456.590755693329;5465.234867118606;5492.121260598305;5516.282883225175;5604.915926261109;5612.298462692163;5612.66324020558;5617.522510586585;5622.381538030813;5400.297961265011;5451.809186678447;5498.505134537911;5517.2551705519845;5539.8892022159735;5490.80782172626;5500.834974950758;5511.118221084647;5543.36251331094;5553.16702494625;5442.809501667422;5474.37044739856;5482.5613950884235;5489.1217405214975;5492.066348720727;5827.912581311284;5888.735006924699;5892.086726557348;5925.466707996301;5951.226340575698;6308.2430108386825;6334.049892516159;6372.458341041017;6426.228852537725;6432;6497.967510162419;6507.8698426031215;6512.185976752906;6514.511411644098;6521.380468855498;6021.969890150565;6025.939740602582;6047.516198704093;6058.061000544879;6058.485028772604;6386.776462823872;6459.838504037342;6532;6582.308857569887;6655.833604159838;6044.879102417927;6113.719560719409;6143.849652621547;6287.842803929939;6320.968395158086;6379.234491861006;6392.968035159794;6407.807765766941;6424.325445828121;6430.7749228776765;6397.712102955378;6400.231972163277;6400.3599640036555;6417.614943103429;6430.453411460078;6247.219097612799;6313.715882785285;6352.364763523703;6360;6428.71070801815;5298.867528311746;5305.893882122413;5310.787568497294;5353.330833645794;5364.8122315718765;4506.909861802746;4509.27851543758;4513.029698614813;4539.72761634303;4549.181147393435;5528.06022976095;5606.21512988182;5612.887742245214;5637;5648.6893220872425;6397.232332120176;6468.159139311953;6486;6489.70796314167;6499.610023398611;5619.719014049281;5646.378898321182;5651.4348565143155;5656.2929633795775;5688.8862222755315;5592.3009623797025;5707.800226992035;5771.5671324649975;5775.595708300462;5785.913211301834;6131.651934473353;6219.191505104308;6307.495400368051;6315;6315.589486683442;6507.12153859223;6523.543351965507;6524.054012168304;6537.640429776408;6541.6402097885075;6288.905666414916;6297.590656607306;6307.306196318493;6313.684315784284;6321.715522801577;6097.32929377777;6109.708332504907;6232.345603711727;6305.527085468517;6308.842278943063;6536.084948107174;6536.215654121535;6540.345965403421;6540.901886471802;6553.737850485927;6142.508599312134;6180.969095154495;6322.2729386119345;6326.114343991937;6334.493240540838;6156;6257.8748425030335;6261.812145635638;6267.0286105653695;6285.182926219562;6191.9690401547705;6219.533534984804;6222.160008398808;6233.127362169391;6238.376162383907;6264.968675156595;6316.778912738032;6333.429991300805;6337.112804207322;6340.619562826245;6022.2171117754415;6096.5732398733435;6125.601835880653;6129.877402452015;6193.504519638328 09:42:57 INFO - PID 8715 | |1;ext.html;716.9139703235612;752.5484709174495;773.1688434932447;1125.9380734059628;1149.5459293579042;34309.485357719626;35427.2914541709;35530.64469355309;35595.82202088986;35599.82200088996;37498.250034999284;37758.43362349567;37834.43248351277;37863.621363786355;37961.81019094901;7055.753048643299;7084.822879428029;7144.178419481774;7159.4988350815465;7163.749268775594;7233.385162261214;7234.059572255599;7254.310840470147;7264.346208841203;7268.3821875140675;7307.4884758066955;7308.123025236952;7312.963435182844;7323.523970941898;7361.521501102438;7254.891176632328;7314.975903373532;7320.890186647204;7324.450666200057;7324.560526368435;7138.428925685933;7155.534890232118;7187.173475050384;7221;7232.746853860142;34066.6593334066;34211.315773684386;34666;34739.82630086859;34775;3383.2387712764676;3427.2288735034667;3428.5885693716914;3435.707964822993;3439.8108104054268;27198.32004199891;27253.863730681416;27394.5890811638;27459;27619.585706214424;3481.9651803481893;3508.0528257370624;3528.629493903129;3540.0264927144985;3549.503069570262;160753;161478;173929;176854;176979.99999999872;41839;41965.37051944224;42036.36945445821;42077;42144.57855421468;43102.78448607737;43250.567494324656;43446.78276608597;43604.56395436068;43614.78192609017;13843.792343114861;13939.581812545437;13957.79063314051;13980.231087290296;14071;11384.715382115348;11402.600908968147;11424.657260282205;11444.313341199555;11456.198066135457;13083.41124649393;13087.41106650203;13100.344982750825;13132.212067275994;13362.064655474023;5427.945720542823;5537.556995440355;5596.188552659842;5617.32592088952;5621.578381621394;949.6581230756922;962.3648392061345;973.464594473037;993.4039576254335;994.6767300627325;21314.36056918295;21551;22051.779482204973;22840.771592283865;22854.42863928415;1054.7363159210197;1084.436093231515;1112.3770688414513;1117.6479408986143;1123.8258069999163;10798.946005269923;11241.55033798639;11322.660320190407;11541.480633371519;12052.457639406073;202119;204842;205267;205599;205896;45505.77247113743;45865.541344586796;46127.30809037867;46281.537184628396;46347.536524635;1375.8005089262;1409.978850317246;1438.1011867582552;1440.1287221231214;1441.4738620403687;20144.697829532277;20735.58528829385;21980.560388792455;22391.664125037812;22499.66250506211;33273.16817079592;33510.32979340448;33587.66412335845;33730.988070357926;33742;162940;163238;163337;163376;163493;30997.380052398374;31287.217819554695;31540.36919261648;33178.17054573655;33389.33221335608;38683.22633547257;39596;39922.800385997885;40007;40013.199736004535;27911;28262.576061358686;29075.255484670986;29181.270468238465;30659;27858.721412785613;29070.27324316909;29194;30406.484587126375;30782.230444239074;32191;32369.982652688872;32937.505937411435;33010.17474563155;33034.83482582668;27578.586321204795;28198;28973.275668108465;29019;29660.555091674072;21337.35987920365;23707.762922370555;23984;24050.759492404854;24214.273571792874 09:42:57 INFO - PID 8715 | |2;jquery.html;403.4291477559254;409.39614069247864;419.8845317537677;436.6572240790978;437.8117409513909;13263.469461221539;13951.441942322295;19808.30670926518;20606.587868242626;20701.99999999998;20432.387028389134;21469.785302146975;21714.89142554289;21721.67417488739;21775;5640.379558248589;5780.4797568218855;5783.334916484616;5784.074548072309;5790.305163380401;5705.087186050233;5753.050746626802;5763.22196503473;5815.941840581582;5821.155932389801;5581.776728930838;5673.886522269552;5687.374388817227;5726.627769194989;5750.798722044729;5777.0756678931375;5834.5915785894795;5851.356350801409;5854.414558544111;5867.823965281048;5266.894662106736;5268.367795864482;5274.393444753864;5280.102382594968;5285.207218917193;24069.51860962771;24424;24518;24525.141620043392;24553.87723061391;1851.2409911936043;1857.1921214271836;1875.681134207188;1876.4089311866855;1879.4267748336752;16022.278997445143;16318.184090795412;16525.173741312887;16653.583660408465;16685.749713754303;2159.5572907553915;2225.643896976476;2251.808596269319;2253.6281513550243;2256.684064231009;110147.44926275397;113823.43088284589;114542;114984;115528;10744.409057501756;11078;11326.660200194008;11509.539618415338;11591.76816463666;16283.348666053225;16324.67350653004;16360.609348205537;16368.181590920645;16411;7960.40296977729;7980.441369104223;8085.9595702021115;8095.959520202479;8179.4274400792565;7474.663640136207;7488.737894173678;7583.7724868254045;7616.314531692175;7636;7188.424926005907;7342.6695798688115;7459.925400746031;7501.737439189602;7504.924950750423;2086.447091520748;2097.7168082309;2126.797954194349;2182.6398644223527;2218.545198234358;890.9420887642283;927.4759760735298;928.2017464980112;969.4958621516913;983.7835676151235;17465.964424127942;17744.822551774574;17755.289788408576;18651.440456786317;19082.809171908382;934.8223837470858;959.9136077752896;971.3443425687774;977.9559919803626;1013.9087482126644;9397.812043759086;9491.525423728786;10053.447060411747;10292.125169360539;10548.050675439094;412350;419066;424910;429061;431864;93276.53361733147;95349.5232523833;95503.52248238714;96382;96387;1103.834424836281;1132.0999805154922;1146.9942650286696;1152.1589239854952;1158.5887010111458;14793.92603036978;15399.3070311834;15563;16075.517734467985;16722.414715484898;45534;45566.544334557555;46378.304325434474;47041.764791175825;47649.52350476451;56922;57539.71230143822;57578;57822.7108864453;58736;9687.17658998993;9730.610775568897;9791;9825.85261221068;9828.066333698287;15564.066156030674;15748.92125539365;16622.16889155513;18168.27326906909;18370.357037504156;13325.13386629866;13403.195808251536;13514.189148651112;13883.236421996888;13995.020348575908;12539.623811285675;13048.608541743763;13208.735825283633;13356.599302020955;13679.452821887013;14912.701745965236;14944.925275373553;15005.849941500444;15042.247887605794;15108.622284442978;10020.64927727526;10070.295079344376;10125.848112278469;10188.184945204217;10225.568420421296;12928.288944108164;12962.287074211008;13087.345632718516;13089.869101308865;13106.017048721575 09:42:57 INFO - PID 8715 | |3;mootools.html;1294.8446186457625;1326.542342891702;1334.7263810918762;1336.7994800779888;1362.9318534073293;10440.321379110352;10768.192385571074;11061.446927653615;11063.502142403591;11068.225224234307;11125.27685700431;11342.376169310684;11373.374464404455;11376.772464550704;11427.942860285686;2293.4266433391654;2307.619242824932;2315.6758053872386;2329.6272596384583;2338.3218866528687;2267.7732226777357;2321.419645088728;2328.3015095471374;2331.9766802332015;2339.532093581282;2252.144185209618;2252.5157091225383;2265.5129147233342;2276.112316196685;2284.463151159476;2198.043850924837;2207.0289072807914;2219.87790671513;2226.532428190082;2227.6324406472913;2179.3570896585547;2180.4875854174256;2298.471351589127;2302.470431800695;2304.5045315257134;10878.836817447745;10891.128709703284;10975.780484390347;10979.83530247047;10983;5748.109043098327;5977.402259774031;5980.162777211194;5989.341172471025;5993.101034844764;3634.727395445352;3744.4383342498572;3783.9243215135543;3821.617838216156;3823.101571130782;1197.15600501647;1259.3388471052679;1272.8663490333474;1277.1251692590606;1297.3448408553713;15713.05721656693;15866.9206653966;15908.681826363409;15938;15999.440019599258;5060.291559181717;5133.666311689728;5139.383274007068;5239.528442440199;5263.184206448007;11879.40602969848;11896.524139034515;11913.70215744596;11941.283522988648;11948.581799637144;6132.938670613326;6249.125122482856;6288.434040936338;6300.086487459293;6309.400606942425;5791.5656325775735;5829.4170582942215;5876.970615146897;5886.764529418861;5903.439173278532;3983.7211395202057;4090.1206240657807;4122.175564887035;4157.127003329335;4205.369194620831;1127.301073334538;1132.360216477704;1135.0805847263578;1146.5700362364114;1147.540983606564;821.3880658909031;822.2065706593166;851.2083762101305;855.5978690015683;875.2910142784365;5907.113932910098;5945.16767652529;6007.579469437097;6133.233345831771;6269.090981807703;940.1679513630486;961.8797650293714;965.1603105298435;965.6764983730529;973.5278389980854;4239.766812825263;4250.53244143144;4429.092036132585;4515.390422293014;4529.479109902338;13493.460261589427;14079.71840563183;14090.365933533016;14105;14169.85830141706;13412.329383530785;13430;13492.392842322119;13546.86453135456;13651.38568764408;8395.74812755606;8817;8828.867566986628;8829.735107946643;8836.381453298336;6530.47756179514;6599.934000659932;6727.293634168342;6873.20958089826;7408.888866666896;12367.196132251735;12512.687182820138;12552.87447125517;12651.051171162384;12720.236785792882;13027.413766380725;13310.467581297027;13373.66565835862;13379.197248165141;13381.330933453482;10230.744231394274;10352.53413596405;10380.117689996436;10435.478226088513;10481.790364192826;10538.613743251366;10549.208809339178;10581.947090264499;10597.629082982367;10648.254622176373;8278.917210828056;8473.745787626382;8554.486730795923;8579.528125952882;8761.824763504821;8291.58542072906;8611.48331100136;8748.56257187151;8857.601407936529;8866.955665221632;6964.4080253179045;6965.930340696528;7019.613921234381;7020.192677841909;7043.823904402431;5368.7047212403695;5568.55451563882;5771.68255745938;5805;5870.970645146917;5788.487308941903;5887.087501437284;5897.026990546512;5951.642901425928;6008.429199226067 09:42:57 INFO - PID 8715 | |4;prototype.html;354.5550334330417;374.23469005882964;380.84766093562575;382.2774955334418;390.34811864186815;6226.43962043416;6246.281677607077;6290.4024117708805;6293.559450838443;6336.809895703136;6118.766650172688;6122.387761223876;6125.816225513242;6159.599626024316;6163.630182189072;4574.794134263966;4723.90552188956;4754.930140718346;4783.952160478386;4811.735354555498;4751.5010923853015;4784.545468180518;4787.736674482902;4788.186008378567;4801.063792560452;4677.9064418711605;4693.488983393885;4693.647976401767;4713.128071306802;4741.217699079648;4723.244280915072;4723.267893476516;4730.645201609876;4734.597559207437;4745.169595320823;4134.813933373005;4139.751614903085;4149;4150.086980864205;4168.103857670615;5949.196858424144;5976.954033044243;6009.759609615654;6017.69911504423;6030.698465076729;5402.486763757437;5431.619786614939;5440.537554307889;5442.12925931849;5461.563074953994;6400.583962042452;6447.6131432114225;6449.8076250437125;6458.418742313214;6461.224653041665;4477.686561940665;4506.121306345264;4510.977445112753;4512.977435112836;4521.186186486431;6551.3121122281955;6778.491613128986;6882.724691012353;6930.3762661360715;6937.826554336131;4332.805023773938;4552.248878934939;4564.657650676212;4568.246239370533;4600.2869555218995;4635.837745678952;4648.163330600524;4650.837220697259;4653.208954477679;4669.579737823612;5328.4671532846405;5360.8659783504945;5363.275957745733;5374.54316383104;5381.434949330264;6326.398992095744;6525.575837570543;6528.51036172289;6554.80335589933;6554.868902622016;1573.8347473515116;1607.871370290374;1607.9517614471586;1609.5171448565384;1616.6524197297638;1030.3920686794827;1046.1055797293357;1050.9789804203874;1071.6088627651006;1078.687180717583;5828.970855145782;5840.445157710011;5848.590598658138;5862.8534286642325;5899.262592175978;6706.698198581075;6747.898781518281;6750.257471678112;6755.2231493378895;6768.56004359715;5763.135529670499;5763.164341170507;5791.971040144772;5798.478136967693;5806.506446951972;3573.874914377984;3591.9102022449647;3593.4430163324205;3607.74745767799;3629.3830048891223;6535.183102112236;6544.709351726952;6545.509086818508;6545.672716364258;6578.605283682994;6839.760608378683;6842.692078856364;6865.759698410531;6907.240203577602;6945.2707465716385;6442.806715798533;6473.471957783019;6531.738730450728;6576.704048317837;6585.769498067544;6772.898406523807;6780.491463140185;6788.250758442839;6815.829604259933;6824.454043676593;6606.10817539626;6680.799576012728;6736.663166841737;6745.12313399255;6750.2237242715755;6208.844778880564;6587;6592.648851757816;6611.471082313499;6640.701168447335;4595.126925884071;4595.954040459553;4598.632109431304;4602.631789456768;4607.861764147081;6763.458743501059;6780.406384616162;6791.777480053638;6793.082933803873;6803.979403089576;6386.521010924293;6521.184851893513;6521.836954076186;6566.80299591013;6597.80206593803;6541.6402097885075;6575.80272591823;6608.273089960005;6612.338766123349;6625.469962403093;6494;6518.674066296571;6520.706568204348;6545.738170473128;6602.504812139205;6567.310432404529;6615.867682646416;6635.601863888182;6662.133922590032;6672.733090676318;6402.583832050902;6429.903551446639;6445.291017987924;6460.12788273577;6478.4169424752 09:42:57 INFO - PID 8715 | |5;yui.html;824.2746383182798;851.5274022917282;855.371302092962;860.4751101827884;864.1272314961889;14477.855221447782;15191.848081519182;15625.687486250283;16002.199890005497;17110.914445427756;17011.149442527887;17943.28226870927;18023.459296221135;18049.007304598243;18071.186796594153;950.0879156010221;977.0180968127022;984.1339621133393;984.2421335571605;984.807962447323;964.7298756348234;985.7584891701507;992.5186284651938;992.8113658404916;994.6518718448558;1048.5753269925692;1049.774298525817;1051.2273478992934;1053.5101177952251;1053.5469748008354;1044.764927891226;1044.984325235122;1045.9215558833118;1047.2250534604414;1047.9476026198658;772.5905270206744;775.3409601838449;775.6548335990486;776.491398134223;776.8407476467311;16953.660926781395;17277.827221727748;17323.740143897852;17416.651666966718;18129.45611631653;18759.43721688338;18894;18997.525061873424;19089.331873384504;19105.331313404102;15032.098074115587;15367.15480648564;15368.462103826425;15370.615734606612;15387.307571159212;3180.77734558581;3198.9680103198903;3203.8077715337154;3238.611366635995;3440.2431465077643;84046.57976710139;85730.57134714349;85931.57034214788;86008;86639.56680216621;14406.639834004023;14587.635309117357;14699;14787;15082.17048062367;24995.75004249934;25909.09318173855;26001.089961851245;26941.326466838487;27115.593266101023;7739.535627862347;7982.720604778805;8027.5584842834205;8035.196480351918;8052.074011488637;3700.259948010355;3798.4112462568346;3808.21931504041;3813.103920578662;3817.0266582021964;4302.462192225972;4356.520782713899;4390.868273951786;4402.229609818269;4411.536788637211;844.7212419901418;871.3203701113142;876.7764220123955;877.8463768840427;878.6002368922125;678.4775722693498;694.1600663197587;698.8776964031376;698.9475789315821;706.2443185791154;10158.898411015794;10525.368477891197;10765.354078755143;12143.514259429701;12186;683.2450142592463;684.3430306905327;689.931006899306;696.7909627111846;704.0671110778239;5153;5264.263003179558;5287.920681189786;5607.915881261784;5670.347909990322;82944;84165;85375;87766.56116719375;88459;71469.6426517864;72202.63898680473;73403;73735;75113.62443187748;61878.690606546676;61977;64347;65453;67865.32134678689;10261.255586550154;10464.947675261576;10723.195760318164;11396.829047564128;11639.941800290944;27570.17289481319;28000.29999250035;28130.156095317172;28735.42529149447;29369.7063029367;35609;35983.82008089943;36358.27283454369;36610.63389366072;37187.25625487421;15716.528504144893;17075.40236091731;17142.657146857244;17487.38794142199;17508.912455437643;18445.631087378446;18926.526836828638;19637.901810490857;20022.69965950483;20048.59902801965;15968.920155399148;16022;16065.919670401574;16385.67228655444;17792.46622601324;15974.440894568634;15981.44064957721;16019.279132438834;16130.919345403197;16145.919270404043;16086.35654573804;16431.342746290014;16434.75347869759;16686.332546697995;17130.82869171342;11129.777404451703;11496.425178740863;11849.229800062969;11906.821397679216;12129.636110916686;13040.608781736562;13191.802122968355;13441.327933603085;14362.569122926328;14468.204248766418 09:42:57 INFO - PID 8715 | __end_tp_report 09:42:57 INFO - PID 8715 | __start_cc_report 09:42:57 INFO - PID 8715 | _x_x_mozilla_cycle_collect,382 09:42:57 INFO - PID 8715 | __end_cc_report 09:42:57 INFO - PID 8715 | __startTimestamp1496680977676__endTimestamp 09:42:57 INFO - PID 8715 | 09:42:57 INFO - PID 8715 | ------- Summary: start ------- 09:42:57 INFO - PID 8715 | Number of tests: 6 09:42:57 INFO - PID 8715 | 09:42:57 INFO - PID 8715 | [#0] dojo.html Cycles:165 Average:5927.22 Median:6129.88 stddev:675.82 (11.0%) stddev-sans-first:639.78 09:42:57 INFO - PID 8715 | Values: 3075.1 3079.3 3096.3 3119.4 3124.4 5873.3 5927.6 5932.6 5945.7 6003.7 5941.7 5993.2 6023.1 6046.1 6101.7 5350.1 5456.6 5465.2 5492.1 5516.3 5604.9 5612.3 5612.7 5617.5 5622.4 5400.3 5451.8 5498.5 5517.3 5539.9 5490.8 5500.8 5511.1 5543.4 5553.2 5442.8 5474.4 5482.6 5489.1 5492.1 5827.9 5888.7 5892.1 5925.5 5951.2 6308.2 6334.0 6372.5 6426.2 6432.0 6498.0 6507.9 6512.2 6514.5 6521.4 6022.0 6025.9 6047.5 6058.1 6058.5 6386.8 6459.8 6532.0 6582.3 6655.8 6044.9 6113.7 6143.8 6287.8 6321.0 6379.2 6393.0 6407.8 6424.3 6430.8 6397.7 6400.2 6400.4 6417.6 6430.5 6247.2 6313.7 6352.4 6360.0 6428.7 5298.9 5305.9 5310.8 5353.3 5364.8 4506.9 4509.3 4513.0 4539.7 4549.2 5528.1 5606.2 5612.9 5637.0 5648.7 6397.2 6468.2 6486.0 6489.7 6499.6 5619.7 5646.4 5651.4 5656.3 5688.9 5592.3 5707.8 5771.6 5775.6 5785.9 6131.7 6219.2 6307.5 6315.0 6315.6 6507.1 6523.5 6524.1 6537.6 6541.6 6288.9 6297.6 6307.3 6313.7 6321.7 6097.3 6109.7 6232.3 6305.5 6308.8 6536.1 6536.2 6540.3 6540.9 6553.7 6142.5 6181.0 6322.3 6326.1 6334.5 6156.0 6257.9 6261.8 6267.0 6285.2 6192.0 6219.5 6222.2 6233.1 6238.4 6265.0 6316.8 6333.4 6337.1 6340.6 6022.2 6096.6 6125.6 6129.9 6193.5 09:42:57 INFO - PID 8715 | 09:42:57 INFO - PID 8715 | [#1] ext.html Cycles:180 Average:33325.87 Median:33225.67 stddev:46594.86 (140.2%) stddev-sans-first:46661.23 09:42:57 INFO - PID 8715 | Values: 716.9 752.5 773.2 1125.9 1149.5 34309.5 35427.3 35530.6 35595.8 35599.8 37498.3 37758.4 37834.4 37863.6 37961.8 7055.8 7084.8 7144.2 7159.5 7163.7 7233.4 7234.1 7254.3 7264.3 7268.4 7307.5 7308.1 7313.0 7323.5 7361.5 7254.9 7315.0 7320.9 7324.5 7324.6 7138.4 7155.5 7187.2 7221.0 7232.7 34066.7 34211.3 34666.0 34739.8 34775.0 3383.2 3427.2 3428.6 3435.7 3439.8 27198.3 27253.9 27394.6 27459.0 27619.6 3482.0 3508.1 3528.6 3540.0 3549.5 160753.0 161478.0 173929.0 176854.0 176980.0 41839.0 41965.4 42036.4 42077.0 42144.6 43102.8 43250.6 43446.8 43604.6 43614.8 13843.8 13939.6 13957.8 13980.2 14071.0 11384.7 11402.6 11424.7 11444.3 11456.2 13083.4 13087.4 13100.3 13132.2 13362.1 5427.9 5537.6 5596.2 5617.3 5621.6 949.7 962.4 973.5 993.4 994.7 21314.4 21551.0 22051.8 22840.8 22854.4 1054.7 1084.4 1112.4 1117.6 1123.8 10798.9 11241.6 11322.7 11541.5 12052.5 202119.0 204842.0 205267.0 205599.0 205896.0 45505.8 45865.5 46127.3 46281.5 46347.5 1375.8 1410.0 1438.1 1440.1 1441.5 20144.7 20735.6 21980.6 22391.7 22499.7 33273.2 33510.3 33587.7 33731.0 33742.0 162940.0 163238.0 163337.0 163376.0 163493.0 30997.4 31287.2 31540.4 33178.2 33389.3 38683.2 39596.0 39922.8 40007.0 40013.2 27911.0 28262.6 29075.3 29181.3 30659.0 27858.7 29070.3 29194.0 30406.5 30782.2 32191.0 32370.0 32937.5 33010.2 33034.8 27578.6 28198.0 28973.3 29019.0 29660.6 21337.4 23707.8 23984.0 24050.8 24214.3 09:42:57 INFO - PID 8715 | 09:42:57 INFO - PID 8715 | [#2] jquery.html Cycles:180 Average:28911.69 Median:2238.73 stddev:71128.59 (3177.2%) stddev-sans-first:71295.92 09:42:57 INFO - PID 8715 | Values: 403.4 409.4 419.9 436.7 437.8 13263.5 13951.4 19808.3 20606.6 20702.0 20432.4 21469.8 21714.9 21721.7 21775.0 5640.4 5780.5 5783.3 5784.1 5790.3 5705.1 5753.1 5763.2 5815.9 5821.2 5581.8 5673.9 5687.4 5726.6 5750.8 5777.1 5834.6 5851.4 5854.4 5867.8 5266.9 5268.4 5274.4 5280.1 5285.2 24069.5 24424.0 24518.0 24525.1 24553.9 1851.2 1857.2 1875.7 1876.4 1879.4 16022.3 16318.2 16525.2 16653.6 16685.7 2159.6 2225.6 2251.8 2253.6 2256.7 110147.4 113823.4 114542.0 114984.0 115528.0 10744.4 11078.0 11326.7 11509.5 11591.8 16283.3 16324.7 16360.6 16368.2 16411.0 7960.4 7980.4 8086.0 8096.0 8179.4 7474.7 7488.7 7583.8 7616.3 7636.0 7188.4 7342.7 7459.9 7501.7 7504.9 2086.4 2097.7 2126.8 2182.6 2218.5 890.9 927.5 928.2 969.5 983.8 17466.0 17744.8 17755.3 18651.4 19082.8 934.8 959.9 971.3 978.0 1013.9 9397.8 9491.5 10053.4 10292.1 10548.1 412350.0 419066.0 424910.0 429061.0 431864.0 93276.5 95349.5 95503.5 96382.0 96387.0 1103.8 1132.1 1147.0 1152.2 1158.6 14793.9 15399.3 15563.0 16075.5 16722.4 45534.0 45566.5 46378.3 47041.8 47649.5 56922.0 57539.7 57578.0 57822.7 58736.0 9687.2 9730.6 9791.0 9825.9 9828.1 15564.1 15748.9 16622.2 18168.3 18370.4 13325.1 13403.2 13514.2 13883.2 13995.0 12539.6 13048.6 13208.7 13356.6 13679.5 14912.7 14944.9 15005.8 15042.2 15108.6 10020.6 10070.3 10125.8 10188.2 10225.6 12928.3 12962.3 13087.3 13089.9 13106.0 09:42:57 INFO - PID 8715 | 09:42:57 INFO - PID 8715 | [#3] mootools.html Cycles:180 Average:6807.35 Median:2328.96 stddev:4316.60 (185.3%) stddev-sans-first:4308.83 09:42:57 INFO - PID 8715 | Values: 1294.8 1326.5 1334.7 1336.8 1362.9 10440.3 10768.2 11061.4 11063.5 11068.2 11125.3 11342.4 11373.4 11376.8 11427.9 2293.4 2307.6 2315.7 2329.6 2338.3 2267.8 2321.4 2328.3 2332.0 2339.5 2252.1 2252.5 2265.5 2276.1 2284.5 2198.0 2207.0 2219.9 2226.5 2227.6 2179.4 2180.5 2298.5 2302.5 2304.5 10878.8 10891.1 10975.8 10979.8 10983.0 5748.1 5977.4 5980.2 5989.3 5993.1 3634.7 3744.4 3783.9 3821.6 3823.1 1197.2 1259.3 1272.9 1277.1 1297.3 15713.1 15866.9 15908.7 15938.0 15999.4 5060.3 5133.7 5139.4 5239.5 5263.2 11879.4 11896.5 11913.7 11941.3 11948.6 6132.9 6249.1 6288.4 6300.1 6309.4 5791.6 5829.4 5877.0 5886.8 5903.4 3983.7 4090.1 4122.2 4157.1 4205.4 1127.3 1132.4 1135.1 1146.6 1147.5 821.4 822.2 851.2 855.6 875.3 5907.1 5945.2 6007.6 6133.2 6269.1 940.2 961.9 965.2 965.7 973.5 4239.8 4250.5 4429.1 4515.4 4529.5 13493.5 14079.7 14090.4 14105.0 14169.9 13412.3 13430.0 13492.4 13546.9 13651.4 8395.7 8817.0 8828.9 8829.7 8836.4 6530.5 6599.9 6727.3 6873.2 7408.9 12367.2 12512.7 12552.9 12651.1 12720.2 13027.4 13310.5 13373.7 13379.2 13381.3 10230.7 10352.5 10380.1 10435.5 10481.8 10538.6 10549.2 10581.9 10597.6 10648.3 8278.9 8473.7 8554.5 8579.5 8761.8 8291.6 8611.5 8748.6 8857.6 8867.0 6964.4 6965.9 7019.6 7020.2 7043.8 5368.7 5568.6 5771.7 5805.0 5871.0 5788.5 5887.1 5897.0 5951.6 6008.4 09:42:57 INFO - PID 8715 | 09:42:57 INFO - PID 8715 | [#4] prototype.html Cycles:180 Average:5412.65 Median:6120.58 stddev:1622.85 (26.5%) stddev-sans-first:1582.37 09:42:57 INFO - PID 8715 | Values: 354.6 374.2 380.8 382.3 390.3 6226.4 6246.3 6290.4 6293.6 6336.8 6118.8 6122.4 6125.8 6159.6 6163.6 4574.8 4723.9 4754.9 4784.0 4811.7 4751.5 4784.5 4787.7 4788.2 4801.1 4677.9 4693.5 4693.6 4713.1 4741.2 4723.2 4723.3 4730.6 4734.6 4745.2 4134.8 4139.8 4149.0 4150.1 4168.1 5949.2 5977.0 6009.8 6017.7 6030.7 5402.5 5431.6 5440.5 5442.1 5461.6 6400.6 6447.6 6449.8 6458.4 6461.2 4477.7 4506.1 4511.0 4513.0 4521.2 6551.3 6778.5 6882.7 6930.4 6937.8 4332.8 4552.2 4564.7 4568.2 4600.3 4635.8 4648.2 4650.8 4653.2 4669.6 5328.5 5360.9 5363.3 5374.5 5381.4 6326.4 6525.6 6528.5 6554.8 6554.9 1573.8 1607.9 1608.0 1609.5 1616.7 1030.4 1046.1 1051.0 1071.6 1078.7 5829.0 5840.4 5848.6 5862.9 5899.3 6706.7 6747.9 6750.3 6755.2 6768.6 5763.1 5763.2 5792.0 5798.5 5806.5 3573.9 3591.9 3593.4 3607.7 3629.4 6535.2 6544.7 6545.5 6545.7 6578.6 6839.8 6842.7 6865.8 6907.2 6945.3 6442.8 6473.5 6531.7 6576.7 6585.8 6772.9 6780.5 6788.3 6815.8 6824.5 6606.1 6680.8 6736.7 6745.1 6750.2 6208.8 6587.0 6592.6 6611.5 6640.7 4595.1 4596.0 4598.6 4602.6 4607.9 6763.5 6780.4 6791.8 6793.1 6804.0 6386.5 6521.2 6521.8 6566.8 6597.8 6541.6 6575.8 6608.3 6612.3 6625.5 6494.0 6518.7 6520.7 6545.7 6602.5 6567.3 6615.9 6635.6 6662.1 6672.7 6402.6 6429.9 6445.3 6460.1 6478.4 09:42:57 INFO - PID 8715 | 09:42:57 INFO - PID 8715 | [#5] yui.html Cycles:180 Average:18481.77 Median:27785.24 stddev:22776.11 (82.0%) stddev-sans-first:22801.40 09:42:57 INFO - PID 8715 | Values: 824.3 851.5 855.4 860.5 864.1 14477.9 15191.8 15625.7 16002.2 17110.9 17011.1 17943.3 18023.5 18049.0 18071.2 950.1 977.0 984.1 984.2 984.8 964.7 985.8 992.5 992.8 994.7 1048.6 1049.8 1051.2 1053.5 1053.5 1044.8 1045.0 1045.9 1047.2 1047.9 772.6 775.3 775.7 776.5 776.8 16953.7 17277.8 17323.7 17416.7 18129.5 18759.4 18894.0 18997.5 19089.3 19105.3 15032.1 15367.2 15368.5 15370.6 15387.3 3180.8 3199.0 3203.8 3238.6 3440.2 84046.6 85730.6 85931.6 86008.0 86639.6 14406.6 14587.6 14699.0 14787.0 15082.2 24995.8 25909.1 26001.1 26941.3 27115.6 7739.5 7982.7 8027.6 8035.2 8052.1 3700.3 3798.4 3808.2 3813.1 3817.0 4302.5 4356.5 4390.9 4402.2 4411.5 844.7 871.3 876.8 877.8 878.6 678.5 694.2 698.9 698.9 706.2 10158.9 10525.4 10765.4 12143.5 12186.0 683.2 684.3 689.9 696.8 704.1 5153.0 5264.3 5287.9 5607.9 5670.3 82944.0 84165.0 85375.0 87766.6 88459.0 71469.6 72202.6 73403.0 73735.0 75113.6 61878.7 61977.0 64347.0 65453.0 67865.3 10261.3 10464.9 10723.2 11396.8 11639.9 27570.2 28000.3 28130.2 28735.4 29369.7 35609.0 35983.8 36358.3 36610.6 37187.3 15716.5 17075.4 17142.7 17487.4 17508.9 18445.6 18926.5 19637.9 20022.7 20048.6 15968.9 16022.0 16065.9 16385.7 17792.5 15974.4 15981.4 16019.3 16130.9 16145.9 16086.4 16431.3 16434.8 16686.3 17130.8 11129.8 11496.4 11849.2 11906.8 12129.6 13040.6 13191.8 13441.3 14362.6 14468.2 09:42:57 INFO - PID 8715 | -------- Summary: end -------- 09:42:57 INFO - PID 8715 | 09:42:58 INFO - TEST-INFO | 8715: exit 0 09:42:58 INFO - TEST-OK | dromaeo_css | took 1143524ms 09:42:58 INFO - TEST-START | kraken 09:42:58 INFO - operating with platform_type : linux_ 09:42:58 INFO - Initialising browser for kraken test... 09:42:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57502/getInfo.html -profile /tmp/tmpi3GFjR/profile 09:42:58 INFO - TEST-INFO | started process 9136 (/builds/slave/test/build/application/firefox/firefox http://localhost:57502/getInfo.html) 09:43:33 INFO - TEST-INFO | 9136: killed by SIGTERM 09:43:33 INFO - Browser initialized. 09:43:33 INFO - Running cycle 1/1 for kraken test... 09:43:33 INFO - TEST-INFO | started process 9363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi3GFjR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:45 INFO - PID 9363 | RSS: Main: 199507968 09:43:45 INFO - PID 9363 | 09:43:47 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57502/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:48 INFO - PID 9363 | RSS: Main: 200232960 09:43:48 INFO - PID 9363 | 09:43:51 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57502/tests/kraken/driver.html?testName=audio-dft) 09:43:52 INFO - PID 9363 | RSS: Main: 197881856 09:43:52 INFO - PID 9363 | 09:43:55 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57502/tests/kraken/driver.html?testName=audio-fft) 09:43:55 INFO - PID 9363 | RSS: Main: 189210624 09:43:55 INFO - PID 9363 | 09:43:57 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57502/tests/kraken/driver.html?testName=audio-oscillator) 09:43:58 INFO - PID 9363 | RSS: Main: 189870080 09:43:58 INFO - PID 9363 | 09:44:00 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:01 INFO - PID 9363 | RSS: Main: 189841408 09:44:01 INFO - PID 9363 | 09:44:04 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57502/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:04 INFO - PID 9363 | RSS: Main: 190976000 09:44:04 INFO - PID 9363 | 09:44:08 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57502/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:09 INFO - PID 9363 | RSS: Main: 190324736 09:44:09 INFO - PID 9363 | 09:44:11 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57502/tests/kraken/driver.html?testName=json-parse-financial) 09:44:12 INFO - PID 9363 | RSS: Main: 190976000 09:44:12 INFO - PID 9363 | 09:44:14 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:14 INFO - PID 9363 | RSS: Main: 191045632 09:44:14 INFO - PID 9363 | 09:44:16 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57502/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:17 INFO - PID 9363 | RSS: Main: 190578688 09:44:17 INFO - PID 9363 | 09:44:19 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:20 INFO - PID 9363 | RSS: Main: 190840832 09:44:20 INFO - PID 9363 | 09:44:22 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:44:23 INFO - PID 9363 | RSS: Main: 190627840 09:44:23 INFO - PID 9363 | 09:44:26 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:44:27 INFO - PID 9363 | RSS: Main: 190357504 09:44:27 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | Cycle 1(1): loaded http://localhost:57502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57502/tests/kraken/driver.html?testName=ai-astar) 09:44:29 INFO - PID 9363 | RSS: Main: 191664128 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | __start_tp_report 09:44:29 INFO - PID 9363 | _x_x_mozilla_page_load 09:44:29 INFO - PID 9363 | _x_x_mozilla_page_load_details 09:44:29 INFO - PID 9363 | |i|pagename|runs| 09:44:29 INFO - PID 9363 | |0;ai-astar;102;110;113;110;110;111;110;110;111;111 09:44:29 INFO - PID 9363 | |1;audio-beat-detection;149;131;123;173;121;122;122;121;141;128 09:44:29 INFO - PID 9363 | |2;audio-dft;165;163;161;163;164;167;166;174;161;163 09:44:29 INFO - PID 9363 | |3;audio-fft;73;74;74;109;75;75;75;75;98;77 09:44:29 INFO - PID 9363 | |4;audio-oscillator;83;84;107;82;84;83;93;82;81;102 09:44:29 INFO - PID 9363 | |5;imaging-gaussian-blur;114;114;117;115;113;114;115;113;114;114 09:44:29 INFO - PID 9363 | |6;imaging-darkroom;150;151;150;150;149;152;151;150;151;149 09:44:29 INFO - PID 9363 | |7;imaging-desaturate;95;95;94;94;94;96;96;97;94;96 09:44:29 INFO - PID 9363 | |8;json-parse-financial;55;58;57;56;58;59;59;60;54;56 09:44:29 INFO - PID 9363 | |9;json-stringify-tinderbox;55;56;55;55;55;55;57;60;57;56 09:44:29 INFO - PID 9363 | |10;stanford-crypto-aes;93;88;87;94;87;86;97;88;110;89 09:44:29 INFO - PID 9363 | |11;stanford-crypto-ccm;131;131;135;136;137;132;145;134;133;131 09:44:29 INFO - PID 9363 | |12;stanford-crypto-pbkdf2;184;187;199;186;194;206;184;184;203;210 09:44:29 INFO - PID 9363 | |13;stanford-crypto-sha256-iterative;75;73;71;78;73;72;72;75;70;73 09:44:29 INFO - PID 9363 | __end_tp_report 09:44:29 INFO - PID 9363 | __start_cc_report 09:44:29 INFO - PID 9363 | _x_x_mozilla_cycle_collect,992 09:44:29 INFO - PID 9363 | __end_cc_report 09:44:29 INFO - PID 9363 | __startTimestamp1496681069260__endTimestamp 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | ------- Summary: start ------- 09:44:29 INFO - PID 9363 | Number of tests: 14 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:2.90 (2.6%) stddev-sans-first:1.00 09:44:29 INFO - PID 9363 | Values: 102.0 110.0 113.0 110.0 110.0 111.0 110.0 110.0 111.0 111.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:129.50 stddev:16.93 (13.1%) stddev-sans-first:16.95 09:44:29 INFO - PID 9363 | Values: 149.0 131.0 123.0 173.0 121.0 122.0 122.0 121.0 141.0 128.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:3.80 (2.3%) stddev-sans-first:4.03 09:44:29 INFO - PID 9363 | Values: 165.0 163.0 161.0 163.0 164.0 167.0 166.0 174.0 161.0 163.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:12.44 (16.6%) stddev-sans-first:12.89 09:44:29 INFO - PID 9363 | Values: 73.0 74.0 74.0 109.0 75.0 75.0 75.0 75.0 98.0 77.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#4] audio-oscillator Cycles:10 Average:88.10 Median:83.00 stddev:9.34 (11.3%) stddev-sans-first:9.72 09:44:29 INFO - PID 9363 | Values: 83.0 84.0 107.0 82.0 84.0 83.0 93.0 82.0 81.0 102.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 09:44:29 INFO - PID 9363 | Values: 114.0 114.0 117.0 115.0 113.0 114.0 115.0 113.0 114.0 114.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 09:44:29 INFO - PID 9363 | Values: 150.0 151.0 150.0 150.0 149.0 152.0 151.0 150.0 151.0 149.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.50 stddev:1.10 (1.2%) stddev-sans-first:1.17 09:44:29 INFO - PID 9363 | Values: 95.0 95.0 94.0 94.0 94.0 96.0 96.0 97.0 94.0 96.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:1.93 (3.3%) stddev-sans-first:1.88 09:44:29 INFO - PID 9363 | Values: 55.0 58.0 57.0 56.0 58.0 59.0 59.0 60.0 54.0 56.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:1.60 (2.8%) stddev-sans-first:1.64 09:44:29 INFO - PID 9363 | Values: 55.0 56.0 55.0 55.0 55.0 55.0 57.0 60.0 57.0 56.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:88.50 stddev:7.31 (8.3%) stddev-sans-first:7.74 09:44:29 INFO - PID 9363 | Values: 93.0 88.0 87.0 94.0 87.0 86.0 97.0 88.0 110.0 89.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:134.50 stddev:4.28 (3.2%) stddev-sans-first:4.34 09:44:29 INFO - PID 9363 | Values: 131.0 131.0 135.0 136.0 137.0 132.0 145.0 134.0 133.0 131.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.70 Median:196.50 stddev:10.10 (5.1%) stddev-sans-first:10.08 09:44:29 INFO - PID 9363 | Values: 184.0 187.0 199.0 186.0 194.0 206.0 184.0 184.0 203.0 210.0 09:44:29 INFO - PID 9363 | 09:44:29 INFO - PID 9363 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:2.30 (3.2%) stddev-sans-first:2.35 09:44:29 INFO - PID 9363 | Values: 75.0 73.0 71.0 78.0 73.0 72.0 72.0 75.0 70.0 73.0 09:44:29 INFO - PID 9363 | -------- Summary: end -------- 09:44:29 INFO - PID 9363 | 09:44:30 INFO - TEST-INFO | 9363: exit 0 09:44:30 INFO - TEST-OK | kraken | took 91919ms 09:44:30 INFO - SUITE-END | took 1235s 09:44:30 INFO - Completed test suite (00:20:35) 09:44:30 INFO - javascript benchmark 09:44:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7535.787283888238, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.092847609955, 3079.2917628945356, 3096.31880986183, 3119.3605310911257, 3124.406362791068, 5873.295204575446, 5927.555433342501, 5932.614380065293, 5945.721669840988, 6003.729832157558, 5941.673207973559, 5993.160957465958, 6023.126646636246, 6046.093086037096, 6101.664408457533, 5350.0904846176045, 5456.590755693329, 5465.234867118606, 5492.121260598305, 5516.282883225175, 5604.915926261109, 5612.298462692163, 5612.66324020558, 5617.522510586585, 5622.381538030813, 5400.297961265011, 5451.809186678447, 5498.505134537911, 5517.2551705519845, 5539.8892022159735, 5490.80782172626, 5500.834974950758, 5511.118221084647, 5543.36251331094, 5553.16702494625, 5442.809501667422, 5474.37044739856, 5482.5613950884235, 5489.1217405214975, 5492.066348720727, 5827.912581311284, 5888.735006924699, 5892.086726557348, 5925.466707996301, 5951.226340575698, 6308.2430108386825, 6334.049892516159, 6372.458341041017, 6426.228852537725, 6432.0, 6497.967510162419, 6507.8698426031215, 6512.185976752906, 6514.511411644098, 6521.380468855498, 6021.969890150565, 6025.939740602582, 6047.516198704093, 6058.061000544879, 6058.485028772604, 6386.776462823872, 6459.838504037342, 6532.0, 6582.308857569887, 6655.833604159838, 6044.879102417927, 6113.719560719409, 6143.849652621547, 6287.842803929939, 6320.968395158086, 6379.234491861006, 6392.968035159794, 6407.807765766941, 6424.325445828121, 6430.7749228776765, 6397.712102955378, 6400.231972163277, 6400.3599640036555, 6417.614943103429, 6430.453411460078, 6247.219097612799, 6313.715882785285, 6352.364763523703, 6360.0, 6428.71070801815, 5298.867528311746, 5305.893882122413, 5310.787568497294, 5353.330833645794, 5364.8122315718765, 4506.909861802746, 4509.27851543758, 4513.029698614813, 4539.72761634303, 4549.181147393435, 5528.06022976095, 5606.21512988182, 5612.887742245214, 5637.0, 5648.6893220872425, 6397.232332120176, 6468.159139311953, 6486.0, 6489.70796314167, 6499.610023398611, 5619.719014049281, 5646.378898321182, 5651.4348565143155, 5656.2929633795775, 5688.8862222755315, 5592.3009623797025, 5707.800226992035, 5771.5671324649975, 5775.595708300462, 5785.913211301834, 6131.651934473353, 6219.191505104308, 6307.495400368051, 6315.0, 6315.589486683442, 6507.12153859223, 6523.543351965507, 6524.054012168304, 6537.640429776408, 6541.6402097885075, 6288.905666414916, 6297.590656607306, 6307.306196318493, 6313.684315784284, 6321.715522801577, 6097.32929377777, 6109.708332504907, 6232.345603711727, 6305.527085468517, 6308.842278943063, 6536.084948107174, 6536.215654121535, 6540.345965403421, 6540.901886471802, 6553.737850485927, 6142.508599312134, 6180.969095154495, 6322.2729386119345, 6326.114343991937, 6334.493240540838, 6156.0, 6257.8748425030335, 6261.812145635638, 6267.0286105653695, 6285.182926219562, 6191.9690401547705, 6219.533534984804, 6222.160008398808, 6233.127362169391, 6238.376162383907, 6264.968675156595, 6316.778912738032, 6333.429991300805, 6337.112804207322, 6340.619562826245, 6022.2171117754415, 6096.5732398733435, 6125.601835880653, 6129.877402452015, 6193.504519638328], "value": 5878.297387514217, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.9139703235612, 752.5484709174495, 773.1688434932447, 1125.9380734059628, 1149.5459293579042, 34309.485357719626, 35427.2914541709, 35530.64469355309, 35595.82202088986, 35599.82200088996, 37498.250034999284, 37758.43362349567, 37834.43248351277, 37863.621363786355, 37961.81019094901, 7055.753048643299, 7084.822879428029, 7144.178419481774, 7159.4988350815465, 7163.749268775594, 7233.385162261214, 7234.059572255599, 7254.310840470147, 7264.346208841203, 7268.3821875140675, 7307.4884758066955, 7308.123025236952, 7312.963435182844, 7323.523970941898, 7361.521501102438, 7254.891176632328, 7314.975903373532, 7320.890186647204, 7324.450666200057, 7324.560526368435, 7138.428925685933, 7155.534890232118, 7187.173475050384, 7221.0, 7232.746853860142, 34066.6593334066, 34211.315773684386, 34666.0, 34739.82630086859, 34775.0, 3383.2387712764676, 3427.2288735034667, 3428.5885693716914, 3435.707964822993, 3439.8108104054268, 27198.32004199891, 27253.863730681416, 27394.5890811638, 27459.0, 27619.585706214424, 3481.9651803481893, 3508.0528257370624, 3528.629493903129, 3540.0264927144985, 3549.503069570262, 160753.0, 161478.0, 173929.0, 176854.0, 176979.99999999872, 41839.0, 41965.37051944224, 42036.36945445821, 42077.0, 42144.57855421468, 43102.78448607737, 43250.567494324656, 43446.78276608597, 43604.56395436068, 43614.78192609017, 13843.792343114861, 13939.581812545437, 13957.79063314051, 13980.231087290296, 14071.0, 11384.715382115348, 11402.600908968147, 11424.657260282205, 11444.313341199555, 11456.198066135457, 13083.41124649393, 13087.41106650203, 13100.344982750825, 13132.212067275994, 13362.064655474023, 5427.945720542823, 5537.556995440355, 5596.188552659842, 5617.32592088952, 5621.578381621394, 949.6581230756922, 962.3648392061345, 973.464594473037, 993.4039576254335, 994.6767300627325, 21314.36056918295, 21551.0, 22051.779482204973, 22840.771592283865, 22854.42863928415, 1054.7363159210197, 1084.436093231515, 1112.3770688414513, 1117.6479408986143, 1123.8258069999163, 10798.946005269923, 11241.55033798639, 11322.660320190407, 11541.480633371519, 12052.457639406073, 202119.0, 204842.0, 205267.0, 205599.0, 205896.0, 45505.77247113743, 45865.541344586796, 46127.30809037867, 46281.537184628396, 46347.536524635, 1375.8005089262, 1409.978850317246, 1438.1011867582552, 1440.1287221231214, 1441.4738620403687, 20144.697829532277, 20735.58528829385, 21980.560388792455, 22391.664125037812, 22499.66250506211, 33273.16817079592, 33510.32979340448, 33587.66412335845, 33730.988070357926, 33742.0, 162940.0, 163238.0, 163337.0, 163376.0, 163493.0, 30997.380052398374, 31287.217819554695, 31540.36919261648, 33178.17054573655, 33389.33221335608, 38683.22633547257, 39596.0, 39922.800385997885, 40007.0, 40013.199736004535, 27911.0, 28262.576061358686, 29075.255484670986, 29181.270468238465, 30659.0, 27858.721412785613, 29070.27324316909, 29194.0, 30406.484587126375, 30782.230444239074, 32191.0, 32369.982652688872, 32937.505937411435, 33010.17474563155, 33034.83482582668, 27578.586321204795, 28198.0, 28973.275668108465, 29019.0, 29660.555091674072, 21337.35987920365, 23707.762922370555, 23984.0, 24050.759492404854, 24214.273571792874], "value": 15651.761143052714, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.4291477559254, 409.39614069247864, 419.8845317537677, 436.6572240790978, 437.8117409513909, 13263.469461221539, 13951.441942322295, 19808.30670926518, 20606.587868242626, 20701.99999999998, 20432.387028389134, 21469.785302146975, 21714.89142554289, 21721.67417488739, 21775.0, 5640.379558248589, 5780.4797568218855, 5783.334916484616, 5784.074548072309, 5790.305163380401, 5705.087186050233, 5753.050746626802, 5763.22196503473, 5815.941840581582, 5821.155932389801, 5581.776728930838, 5673.886522269552, 5687.374388817227, 5726.627769194989, 5750.798722044729, 5777.0756678931375, 5834.5915785894795, 5851.356350801409, 5854.414558544111, 5867.823965281048, 5266.894662106736, 5268.367795864482, 5274.393444753864, 5280.102382594968, 5285.207218917193, 24069.51860962771, 24424.0, 24518.0, 24525.141620043392, 24553.87723061391, 1851.2409911936043, 1857.1921214271836, 1875.681134207188, 1876.4089311866855, 1879.4267748336752, 16022.278997445143, 16318.184090795412, 16525.173741312887, 16653.583660408465, 16685.749713754303, 2159.5572907553915, 2225.643896976476, 2251.808596269319, 2253.6281513550243, 2256.684064231009, 110147.44926275397, 113823.43088284589, 114542.0, 114984.0, 115528.0, 10744.409057501756, 11078.0, 11326.660200194008, 11509.539618415338, 11591.76816463666, 16283.348666053225, 16324.67350653004, 16360.609348205537, 16368.181590920645, 16411.0, 7960.40296977729, 7980.441369104223, 8085.9595702021115, 8095.959520202479, 8179.4274400792565, 7474.663640136207, 7488.737894173678, 7583.7724868254045, 7616.314531692175, 7636.0, 7188.424926005907, 7342.6695798688115, 7459.925400746031, 7501.737439189602, 7504.924950750423, 2086.447091520748, 2097.7168082309, 2126.797954194349, 2182.6398644223527, 2218.545198234358, 890.9420887642283, 927.4759760735298, 928.2017464980112, 969.4958621516913, 983.7835676151235, 17465.964424127942, 17744.822551774574, 17755.289788408576, 18651.440456786317, 19082.809171908382, 934.8223837470858, 959.9136077752896, 971.3443425687774, 977.9559919803626, 1013.9087482126644, 9397.812043759086, 9491.525423728786, 10053.447060411747, 10292.125169360539, 10548.050675439094, 412350.0, 419066.0, 424910.0, 429061.0, 431864.0, 93276.53361733147, 95349.5232523833, 95503.52248238714, 96382.0, 96387.0, 1103.834424836281, 1132.0999805154922, 1146.9942650286696, 1152.1589239854952, 1158.5887010111458, 14793.92603036978, 15399.3070311834, 15563.0, 16075.517734467985, 16722.414715484898, 45534.0, 45566.544334557555, 46378.304325434474, 47041.764791175825, 47649.52350476451, 56922.0, 57539.71230143822, 57578.0, 57822.7108864453, 58736.0, 9687.17658998993, 9730.610775568897, 9791.0, 9825.85261221068, 9828.066333698287, 15564.066156030674, 15748.92125539365, 16622.16889155513, 18168.27326906909, 18370.357037504156, 13325.13386629866, 13403.195808251536, 13514.189148651112, 13883.236421996888, 13995.020348575908, 12539.623811285675, 13048.608541743763, 13208.735825283633, 13356.599302020955, 13679.452821887013, 14912.701745965236, 14944.925275373553, 15005.849941500444, 15042.247887605794, 15108.622284442978, 10020.64927727526, 10070.295079344376, 10125.848112278469, 10188.184945204217, 10225.568420421296, 12928.288944108164, 12962.287074211008, 13087.345632718516, 13089.869101308865, 13106.017048721575], "value": 9854.813414213688, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.8446186457625, 1326.542342891702, 1334.7263810918762, 1336.7994800779888, 1362.9318534073293, 10440.321379110352, 10768.192385571074, 11061.446927653615, 11063.502142403591, 11068.225224234307, 11125.27685700431, 11342.376169310684, 11373.374464404455, 11376.772464550704, 11427.942860285686, 2293.4266433391654, 2307.619242824932, 2315.6758053872386, 2329.6272596384583, 2338.3218866528687, 2267.7732226777357, 2321.419645088728, 2328.3015095471374, 2331.9766802332015, 2339.532093581282, 2252.144185209618, 2252.5157091225383, 2265.5129147233342, 2276.112316196685, 2284.463151159476, 2198.043850924837, 2207.0289072807914, 2219.87790671513, 2226.532428190082, 2227.6324406472913, 2179.3570896585547, 2180.4875854174256, 2298.471351589127, 2302.470431800695, 2304.5045315257134, 10878.836817447745, 10891.128709703284, 10975.780484390347, 10979.83530247047, 10983.0, 5748.109043098327, 5977.402259774031, 5980.162777211194, 5989.341172471025, 5993.101034844764, 3634.727395445352, 3744.4383342498572, 3783.9243215135543, 3821.617838216156, 3823.101571130782, 1197.15600501647, 1259.3388471052679, 1272.8663490333474, 1277.1251692590606, 1297.3448408553713, 15713.05721656693, 15866.9206653966, 15908.681826363409, 15938.0, 15999.440019599258, 5060.291559181717, 5133.666311689728, 5139.383274007068, 5239.528442440199, 5263.184206448007, 11879.40602969848, 11896.524139034515, 11913.70215744596, 11941.283522988648, 11948.581799637144, 6132.938670613326, 6249.125122482856, 6288.434040936338, 6300.086487459293, 6309.400606942425, 5791.5656325775735, 5829.4170582942215, 5876.970615146897, 5886.764529418861, 5903.439173278532, 3983.7211395202057, 4090.1206240657807, 4122.175564887035, 4157.127003329335, 4205.369194620831, 1127.301073334538, 1132.360216477704, 1135.0805847263578, 1146.5700362364114, 1147.540983606564, 821.3880658909031, 822.2065706593166, 851.2083762101305, 855.5978690015683, 875.2910142784365, 5907.113932910098, 5945.16767652529, 6007.579469437097, 6133.233345831771, 6269.090981807703, 940.1679513630486, 961.8797650293714, 965.1603105298435, 965.6764983730529, 973.5278389980854, 4239.766812825263, 4250.53244143144, 4429.092036132585, 4515.390422293014, 4529.479109902338, 13493.460261589427, 14079.71840563183, 14090.365933533016, 14105.0, 14169.85830141706, 13412.329383530785, 13430.0, 13492.392842322119, 13546.86453135456, 13651.38568764408, 8395.74812755606, 8817.0, 8828.867566986628, 8829.735107946643, 8836.381453298336, 6530.47756179514, 6599.934000659932, 6727.293634168342, 6873.20958089826, 7408.888866666896, 12367.196132251735, 12512.687182820138, 12552.87447125517, 12651.051171162384, 12720.236785792882, 13027.413766380725, 13310.467581297027, 13373.66565835862, 13379.197248165141, 13381.330933453482, 10230.744231394274, 10352.53413596405, 10380.117689996436, 10435.478226088513, 10481.790364192826, 10538.613743251366, 10549.208809339178, 10581.947090264499, 10597.629082982367, 10648.254622176373, 8278.917210828056, 8473.745787626382, 8554.486730795923, 8579.528125952882, 8761.824763504821, 8291.58542072906, 8611.48331100136, 8748.56257187151, 8857.601407936529, 8866.955665221632, 6964.4080253179045, 6965.930340696528, 7019.613921234381, 7020.192677841909, 7043.823904402431, 5368.7047212403695, 5568.55451563882, 5771.68255745938, 5805.0, 5870.970645146917, 5788.487308941903, 5887.087501437284, 5897.026990546512, 5951.642901425928, 6008.429199226067], "value": 5142.796662159448, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.5550334330417, 374.23469005882964, 380.84766093562575, 382.2774955334418, 390.34811864186815, 6226.43962043416, 6246.281677607077, 6290.4024117708805, 6293.559450838443, 6336.809895703136, 6118.766650172688, 6122.387761223876, 6125.816225513242, 6159.599626024316, 6163.630182189072, 4574.794134263966, 4723.90552188956, 4754.930140718346, 4783.952160478386, 4811.735354555498, 4751.5010923853015, 4784.545468180518, 4787.736674482902, 4788.186008378567, 4801.063792560452, 4677.9064418711605, 4693.488983393885, 4693.647976401767, 4713.128071306802, 4741.217699079648, 4723.244280915072, 4723.267893476516, 4730.645201609876, 4734.597559207437, 4745.169595320823, 4134.813933373005, 4139.751614903085, 4149.0, 4150.086980864205, 4168.103857670615, 5949.196858424144, 5976.954033044243, 6009.759609615654, 6017.69911504423, 6030.698465076729, 5402.486763757437, 5431.619786614939, 5440.537554307889, 5442.12925931849, 5461.563074953994, 6400.583962042452, 6447.6131432114225, 6449.8076250437125, 6458.418742313214, 6461.224653041665, 4477.686561940665, 4506.121306345264, 4510.977445112753, 4512.977435112836, 4521.186186486431, 6551.3121122281955, 6778.491613128986, 6882.724691012353, 6930.3762661360715, 6937.826554336131, 4332.805023773938, 4552.248878934939, 4564.657650676212, 4568.246239370533, 4600.2869555218995, 4635.837745678952, 4648.163330600524, 4650.837220697259, 4653.208954477679, 4669.579737823612, 5328.4671532846405, 5360.8659783504945, 5363.275957745733, 5374.54316383104, 5381.434949330264, 6326.398992095744, 6525.575837570543, 6528.51036172289, 6554.80335589933, 6554.868902622016, 1573.8347473515116, 1607.871370290374, 1607.9517614471586, 1609.5171448565384, 1616.6524197297638, 1030.3920686794827, 1046.1055797293357, 1050.9789804203874, 1071.6088627651006, 1078.687180717583, 5828.970855145782, 5840.445157710011, 5848.590598658138, 5862.8534286642325, 5899.262592175978, 6706.698198581075, 6747.898781518281, 6750.257471678112, 6755.2231493378895, 6768.56004359715, 5763.135529670499, 5763.164341170507, 5791.971040144772, 5798.478136967693, 5806.506446951972, 3573.874914377984, 3591.9102022449647, 3593.4430163324205, 3607.74745767799, 3629.3830048891223, 6535.183102112236, 6544.709351726952, 6545.509086818508, 6545.672716364258, 6578.605283682994, 6839.760608378683, 6842.692078856364, 6865.759698410531, 6907.240203577602, 6945.2707465716385, 6442.806715798533, 6473.471957783019, 6531.738730450728, 6576.704048317837, 6585.769498067544, 6772.898406523807, 6780.491463140185, 6788.250758442839, 6815.829604259933, 6824.454043676593, 6606.10817539626, 6680.799576012728, 6736.663166841737, 6745.12313399255, 6750.2237242715755, 6208.844778880564, 6587.0, 6592.648851757816, 6611.471082313499, 6640.701168447335, 4595.126925884071, 4595.954040459553, 4598.632109431304, 4602.631789456768, 4607.861764147081, 6763.458743501059, 6780.406384616162, 6791.777480053638, 6793.082933803873, 6803.979403089576, 6386.521010924293, 6521.184851893513, 6521.836954076186, 6566.80299591013, 6597.80206593803, 6541.6402097885075, 6575.80272591823, 6608.273089960005, 6612.338766123349, 6625.469962403093, 6494.0, 6518.674066296571, 6520.706568204348, 6545.738170473128, 6602.504812139205, 6567.310432404529, 6615.867682646416, 6635.601863888182, 6662.133922590032, 6672.733090676318, 6402.583832050902, 6429.903551446639, 6445.291017987924, 6460.12788273577, 6478.4169424752], "value": 4890.350805427614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [824.2746383182798, 851.5274022917282, 855.371302092962, 860.4751101827884, 864.1272314961889, 14477.855221447782, 15191.848081519182, 15625.687486250283, 16002.199890005497, 17110.914445427756, 17011.149442527887, 17943.28226870927, 18023.459296221135, 18049.007304598243, 18071.186796594153, 950.0879156010221, 977.0180968127022, 984.1339621133393, 984.2421335571605, 984.807962447323, 964.7298756348234, 985.7584891701507, 992.5186284651938, 992.8113658404916, 994.6518718448558, 1048.5753269925692, 1049.774298525817, 1051.2273478992934, 1053.5101177952251, 1053.5469748008354, 1044.764927891226, 1044.984325235122, 1045.9215558833118, 1047.2250534604414, 1047.9476026198658, 772.5905270206744, 775.3409601838449, 775.6548335990486, 776.491398134223, 776.8407476467311, 16953.660926781395, 17277.827221727748, 17323.740143897852, 17416.651666966718, 18129.45611631653, 18759.43721688338, 18894.0, 18997.525061873424, 19089.331873384504, 19105.331313404102, 15032.098074115587, 15367.15480648564, 15368.462103826425, 15370.615734606612, 15387.307571159212, 3180.77734558581, 3198.9680103198903, 3203.8077715337154, 3238.611366635995, 3440.2431465077643, 84046.57976710139, 85730.57134714349, 85931.57034214788, 86008.0, 86639.56680216621, 14406.639834004023, 14587.635309117357, 14699.0, 14787.0, 15082.17048062367, 24995.75004249934, 25909.09318173855, 26001.089961851245, 26941.326466838487, 27115.593266101023, 7739.535627862347, 7982.720604778805, 8027.5584842834205, 8035.196480351918, 8052.074011488637, 3700.259948010355, 3798.4112462568346, 3808.21931504041, 3813.103920578662, 3817.0266582021964, 4302.462192225972, 4356.520782713899, 4390.868273951786, 4402.229609818269, 4411.536788637211, 844.7212419901418, 871.3203701113142, 876.7764220123955, 877.8463768840427, 878.6002368922125, 678.4775722693498, 694.1600663197587, 698.8776964031376, 698.9475789315821, 706.2443185791154, 10158.898411015794, 10525.368477891197, 10765.354078755143, 12143.514259429701, 12186.0, 683.2450142592463, 684.3430306905327, 689.931006899306, 696.7909627111846, 704.0671110778239, 5153.0, 5264.263003179558, 5287.920681189786, 5607.915881261784, 5670.347909990322, 82944.0, 84165.0, 85375.0, 87766.56116719375, 88459.0, 71469.6426517864, 72202.63898680473, 73403.0, 73735.0, 75113.62443187748, 61878.690606546676, 61977.0, 64347.0, 65453.0, 67865.32134678689, 10261.255586550154, 10464.947675261576, 10723.195760318164, 11396.829047564128, 11639.941800290944, 27570.17289481319, 28000.29999250035, 28130.156095317172, 28735.42529149447, 29369.7063029367, 35609.0, 35983.82008089943, 36358.27283454369, 36610.63389366072, 37187.25625487421, 15716.528504144893, 17075.40236091731, 17142.657146857244, 17487.38794142199, 17508.912455437643, 18445.631087378446, 18926.526836828638, 19637.901810490857, 20022.69965950483, 20048.59902801965, 15968.920155399148, 16022.0, 16065.919670401574, 16385.67228655444, 17792.46622601324, 15974.440894568634, 15981.44064957721, 16019.279132438834, 16130.919345403197, 16145.919270404043, 16086.35654573804, 16431.342746290014, 16434.75347869759, 16686.332546697995, 17130.82869171342, 11129.777404451703, 11496.425178740863, 11849.229800062969, 11906.821397679216, 12129.636110916686, 13040.608781736562, 13191.802122968355, 13441.327933603085, 14362.569122926328, 14468.204248766418], "value": 8030.489302147264, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 113.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 131.0, 123.0, 173.0, 121.0, 122.0, 122.0, 121.0, 141.0, 128.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 161.0, 163.0, 164.0, 167.0, 166.0, 174.0, 161.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 109.0, 75.0, 75.0, 75.0, 75.0, 98.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 107.0, 82.0, 84.0, 83.0, 93.0, 82.0, 81.0, 102.0], "value": 88.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 117.0, 115.0, 113.0, 114.0, 115.0, 113.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 150.0, 149.0, 152.0, 151.0, 150.0, 151.0, 149.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 96.0, 96.0, 97.0, 94.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 57.0, 56.0, 58.0, 59.0, 59.0, 60.0, 54.0, 56.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 55.0, 55.0, 57.0, 60.0, 57.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 88.0, 87.0, 94.0, 87.0, 86.0, 97.0, 88.0, 110.0, 89.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 135.0, 136.0, 137.0, 132.0, 145.0, 134.0, 133.0, 131.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 199.0, 186.0, 194.0, 206.0, 184.0, 184.0, 203.0, 210.0], "value": 193.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 71.0, 78.0, 73.0, 72.0, 72.0, 75.0, 70.0, 73.0], "value": 73.2, "unit": "score"}]}]} 09:44:31 INFO - Return code: 0 09:44:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:44:31 INFO - # TBPL SUCCESS # 09:44:31 INFO - Running post-action listener: _resource_record_post_action 09:44:31 INFO - [mozharness: 2017-06-05 16:44:31.127045Z] Finished run-tests step (success) 09:44:31 INFO - Running post-run listener: _resource_record_post_run 09:44:31 INFO - Total resource usage - Wall time: 1253s; CPU: 13.0%; Read bytes: 16384; Write bytes: 432472064; Read time: 372; Write time: 314912 09:44:31 INFO - TinderboxPrint: CPU usage
12.7% 09:44:31 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 372 09:44:31 INFO - TinderboxPrint: I/O write bytes / time
432,472,064 / 314,912 09:44:31 INFO - TinderboxPrint: CPU idle
8,730.0 (87.3%) 09:44:31 INFO - TinderboxPrint: CPU user
1,215.3 (12.2%) 09:44:31 INFO - TinderboxPrint: Swap in / out
0 / 0 09:44:31 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 104022016; Read time: 32; Write time: 102136 09:44:31 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:44:31 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 12288; Write bytes: 328450048; Read time: 340; Write time: 212776 09:44:31 INFO - Running post-run listener: _upload_blobber_files 09:44:31 INFO - Blob upload gear active. 09:44:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44:31 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 09:44:31 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'] 09:44:31 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 09:44:32 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:44:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:44:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:33 INFO - (blobuploader) - INFO - Done attempting. 09:44:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:44:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:36 INFO - (blobuploader) - INFO - Done attempting. 09:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:44:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:37 INFO - (blobuploader) - INFO - Done attempting. 09:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:44:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:38 INFO - (blobuploader) - INFO - Done attempting. 09:44:38 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:38 INFO - Return code: 0 09:44:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a7470a95b3fe5e6d490eccca95ce32487ae5d2d5c40ae3e5f4a5221adae5ffc657314114b08a62677c54f8078357186c336aa383d08e1915d2c4996cc4ceed9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe7f424ba77e3c06270ed5a9c9b5a9c2221bf2a8a20fe022b18776834f724a849166a47167ab74b8881d36294f9d6ee6c53eaefd1bcb5b4a0347ab87d954ca79", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a19a442bca1b9eae5cc4ac8d3e02a481fc520ab99cfc89911929514f3848fb4654a6e803b2110478a9daaebf302cd74fe2a02747590bad71933cf764f89312d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/020e8cb0d3768b6ba8c3dc7a9a04086782d364b09530bbaa7c94bcd7b7013d021cb50a08b148d973c68e1f2eae821f7aeb8bf67fd9e40f44b87e9d6a8c3751c6"} 09:44:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:38 INFO - Contents: 09:44:38 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a7470a95b3fe5e6d490eccca95ce32487ae5d2d5c40ae3e5f4a5221adae5ffc657314114b08a62677c54f8078357186c336aa383d08e1915d2c4996cc4ceed9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe7f424ba77e3c06270ed5a9c9b5a9c2221bf2a8a20fe022b18776834f724a849166a47167ab74b8881d36294f9d6ee6c53eaefd1bcb5b4a0347ab87d954ca79", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a19a442bca1b9eae5cc4ac8d3e02a481fc520ab99cfc89911929514f3848fb4654a6e803b2110478a9daaebf302cd74fe2a02747590bad71933cf764f89312d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/020e8cb0d3768b6ba8c3dc7a9a04086782d364b09530bbaa7c94bcd7b7013d021cb50a08b148d973c68e1f2eae821f7aeb8bf67fd9e40f44b87e9d6a8c3751c6"} 09:44:38 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:38 INFO - Copying logs to upload dir... 09:44:38 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1311.681477 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-06-05 09:44:38.192155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 09:44:38.199535) ========= 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=5c37b704b588aaa989324530000001d0-1496679765.294408-569337594 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/9a7470a95b3fe5e6d490eccca95ce32487ae5d2d5c40ae3e5f4a5221adae5ffc657314114b08a62677c54f8078357186c336aa383d08e1915d2c4996cc4ceed9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe7f424ba77e3c06270ed5a9c9b5a9c2221bf2a8a20fe022b18776834f724a849166a47167ab74b8881d36294f9d6ee6c53eaefd1bcb5b4a0347ab87d954ca79", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a19a442bca1b9eae5cc4ac8d3e02a481fc520ab99cfc89911929514f3848fb4654a6e803b2110478a9daaebf302cd74fe2a02747590bad71933cf764f89312d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/020e8cb0d3768b6ba8c3dc7a9a04086782d364b09530bbaa7c94bcd7b7013d021cb50a08b148d973c68e1f2eae821f7aeb8bf67fd9e40f44b87e9d6a8c3751c6"} build_url:https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/EaTerL3kThu0D8gfNguL3Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a7470a95b3fe5e6d490eccca95ce32487ae5d2d5c40ae3e5f4a5221adae5ffc657314114b08a62677c54f8078357186c336aa383d08e1915d2c4996cc4ceed9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe7f424ba77e3c06270ed5a9c9b5a9c2221bf2a8a20fe022b18776834f724a849166a47167ab74b8881d36294f9d6ee6c53eaefd1bcb5b4a0347ab87d954ca79", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a19a442bca1b9eae5cc4ac8d3e02a481fc520ab99cfc89911929514f3848fb4654a6e803b2110478a9daaebf302cd74fe2a02747590bad71933cf764f89312d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/020e8cb0d3768b6ba8c3dc7a9a04086782d364b09530bbaa7c94bcd7b7013d021cb50a08b148d973c68e1f2eae821f7aeb8bf67fd9e40f44b87e9d6a8c3751c6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 09:44:38.231120) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:44:38.231473) ========= 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=5c37b704b588aaa989324530000001d0-1496679765.294408-569337594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:44:38.312917) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 09:44:38.313249) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 09:44:38.313568) ========= ========= Total master_lag: 0.16 =========