builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1496193026.91 results: success (0) revision: 5b2c84104a7f4774fd120ab38d21b6483bcb63c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 18:10:26.909474) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 18:10:26.910339) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 18:10:26.911662) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 18:10:26.993168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:10:26.993466) ========= 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=920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 18:10:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-05-30 18:10:27 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092514 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:10:27.122913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:10:27.123250) ========= 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=920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016770 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:10:27.177034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-30 18:10:27.177428) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5b2c84104a7f4774fd120ab38d21b6483bcb63c7 --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 5b2c84104a7f4774fd120ab38d21b6483bcb63c7 --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=920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 18:10:27,975 truncating revision to first 12 chars 2017-05-30 18:10:27,975 Setting DEBUG logging. 2017-05-30 18:10:27,975 attempt 1/10 2017-05-30 18:10:27,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5b2c84104a7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 18:10:29,309 unpacking tar archive at: mozilla-central-5b2c84104a7f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.686063 ========= master_lag: 0.46 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-30 18:10:29.322146) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 18:10:29.322499) ========= script_repo_revision: 5b2c84104a7f4774fd120ab38d21b6483bcb63c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 18:10:29.322912) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 18:10:29.326261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 18:10:29.349596) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2017-05-30 18:10:29.349889) ========= /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=920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:10:30 INFO - MultiFileLogger online at 20170530 18:10:30 in /builds/slave/test 18:10:30 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 18:10:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:10:30 INFO - {'append_to_log': False, 18:10:30 INFO - 'base_work_dir': '/builds/slave/test', 18:10:30 INFO - 'blob_upload_branch': 'Firefox', 18:10:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:10:30 INFO - 'branch': 'Firefox', 18:10:30 INFO - 'buildbot_json_path': 'buildprops.json', 18:10:30 INFO - 'config_files': ('talos/linux_config.py',), 18:10:30 INFO - 'default_actions': ('clobber', 18:10:30 INFO - 'read-buildbot-config', 18:10:30 INFO - 'download-and-extract', 18:10:30 INFO - 'populate-webroot', 18:10:30 INFO - 'create-virtualenv', 18:10:30 INFO - 'install', 18:10:30 INFO - 'setup-mitmproxy', 18:10:30 INFO - 'run-tests'), 18:10:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:10:30 INFO - 'download_minidump_stackwalk': True, 18:10:30 INFO - 'download_symbols': 'ondemand', 18:10:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:10:30 INFO - 'tooltool.py': '/tools/tooltool.py', 18:10:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:10:30 INFO - '/tools/misc-python/virtualenv.py')}, 18:10:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:10:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:10:30 INFO - 'gecko_profile': False, 18:10:30 INFO - 'gecko_profile_interval': 0, 18:10:30 INFO - 'installer_path': 'installer.exe', 18:10:30 INFO - 'log_level': 'info', 18:10:30 INFO - 'log_name': 'talos', 18:10:30 INFO - 'log_to_console': True, 18:10:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:10:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:10:30 INFO - 'opt_config_files': (), 18:10:30 INFO - 'pip_index': False, 18:10:30 INFO - 'suite': 'dromaeojs-e10s', 18:10:30 INFO - 'system_bits': '32', 18:10:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:10:30 INFO - 'title': 'talos-linux64-ix-053', 18:10:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:10:30 INFO - 'use_talos_json': True, 18:10:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:10:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:10:30 INFO - 'work_dir': 'build'} 18:10:30 INFO - [mozharness: 2017-05-31 01:10:30.239358Z] Running clobber step. 18:10:30 INFO - Running pre-action listener: _resource_record_pre_action 18:10:30 INFO - Running main action method: clobber 18:10:30 INFO - rmtree: /builds/slave/test/build 18:10:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:10:31 INFO - Running post-action listener: _resource_record_post_action 18:10:31 INFO - [mozharness: 2017-05-31 01:10:31.267316Z] Finished clobber step (success) 18:10:31 INFO - [mozharness: 2017-05-31 01:10:31.267417Z] Running read-buildbot-config step. 18:10:31 INFO - Running pre-action listener: _resource_record_pre_action 18:10:31 INFO - Running main action method: read_buildbot_config 18:10:31 INFO - Using buildbot properties: 18:10:31 INFO - { 18:10:31 INFO - "project": "", 18:10:31 INFO - "product": "firefox", 18:10:31 INFO - "who": "ryanvm@gmail.com", 18:10:31 INFO - "installer_path": "public/build/target.tar.bz2", 18:10:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:10:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:10:31 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:10:31 INFO - "stage_platform": "linux64-stylo", 18:10:31 INFO - "basedir": "/builds/slave/test", 18:10:31 INFO - "buildnumber": 121, 18:10:31 INFO - "platform": "ubuntu64_hw_stylo", 18:10:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:10:31 INFO - "slavebuilddir": "test", 18:10:31 INFO - "taskId": "bP3f2v_4TFiCgqLLfRGfDg", 18:10:31 INFO - "branch": "mozilla-central", 18:10:31 INFO - "script_repo_revision": "production", 18:10:31 INFO - "revision": "5b2c84104a7f4774fd120ab38d21b6483bcb63c7", 18:10:31 INFO - "slavename": "talos-linux64-ix-053", 18:10:31 INFO - "repo_path": "mozilla-central" 18:10:31 INFO - } 18:10:31 INFO - Finding installer, test and symbols from parent task. 18:10:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bP3f2v_4TFiCgqLLfRGfDg'}, attempt #1 18:10:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bP3f2v_4TFiCgqLLfRGfDg'}, attempt #1 18:10:32 INFO - Task dependencies: P5nXGJZ6QkihNdzCz1Oq7w 18:10:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w'}, attempt #1 18:10:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.tar.bz2 18:10:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/test_packages.json 18:10:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.crashreporter-symbols.zip 18:10:32 INFO - Running post-action listener: _resource_record_post_action 18:10:32 INFO - [mozharness: 2017-05-31 01:10:32.612377Z] Finished read-buildbot-config step (success) 18:10:32 INFO - [mozharness: 2017-05-31 01:10:32.612596Z] Running download-and-extract step. 18:10:32 INFO - Running pre-action listener: _resource_record_pre_action 18:10:32 INFO - Running main action method: download_and_extract 18:10:32 INFO - mkdir: /builds/slave/test/build/tests 18:10: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')]} 18:10:32 INFO - trying https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.test_packages.json 18:10:32 INFO - Downloading https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:10:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:10:33 INFO - Downloaded 986 bytes. 18:10:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:10:33 INFO - Using the following test package requirements: 18:10:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:10:33 INFO - u'common': [u'target.common.tests.zip'], 18:10:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:10:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:10:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:10:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:10:33 INFO - u'mozbase': [u'target.common.tests.zip'], 18:10:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:10:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:10:33 INFO - u'web-platform': [u'target.common.tests.zip', 18:10:33 INFO - u'target.web-platform.tests.zip'], 18:10:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:10:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:10:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.common.tests.zip 18:10:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:10:33 INFO - Fetch https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.common.tests.zip into memory 18:10:36 INFO - Content-Length response header: 63526910 18:10:36 INFO - Bytes received: 63526910 18:10:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:10:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.common.tests.zip 18:10:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:10:47 INFO - Fetch https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.common.tests.zip into memory 18:10:49 INFO - Content-Length response header: 63526910 18:10:49 INFO - Bytes received: 63526910 18:11:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.talos.tests.zip 18:11:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:11:01 INFO - Fetch https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.talos.tests.zip into memory 18:11:02 INFO - Content-Length response header: 14447425 18:11:02 INFO - Bytes received: 14447425 18:11:03 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')]} 18:11:03 INFO - trying https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.tar.bz2 18:11:03 INFO - Downloading https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:11:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:11:06 INFO - Downloaded 55986888 bytes. 18:11:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.tar.bz2 18:11:06 INFO - mkdir: /builds/slave/test/properties 18:11:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:11:06 INFO - Writing to file /builds/slave/test/properties/build_url 18:11:06 INFO - Contents: 18:11:06 INFO - build_url:https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.tar.bz2 18:11:06 INFO - Running post-action listener: _resource_record_post_action 18:11:06 INFO - Running post-action listener: set_extra_try_arguments 18:11:06 INFO - [mozharness: 2017-05-31 01:11:06.052493Z] Finished download-and-extract step (success) 18:11:06 INFO - [mozharness: 2017-05-31 01:11:06.052719Z] Running populate-webroot step. 18:11:06 INFO - Running pre-action listener: _resource_record_pre_action 18:11:06 INFO - Running main action method: populate_webroot 18:11:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:11:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:11:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:11:06 INFO - '--tppagecycles', 18:11:06 INFO - '7'], 18:11:06 INFO - 'tests': ['tsvgm']}}, 18:11:06 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:11:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:11:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:11:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:11:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:11:06 INFO - 'talos_options': ['--disable-e10s'], 18:11:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:11:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:11:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:11:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:11:06 INFO - 'talos_options': ['--disable-e10s'], 18:11:06 INFO - 'tests': ['damp', 'tps']}, 18:11:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:11:06 INFO - 'tests': ['damp', 'tps']}, 18:11:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:11:06 INFO - 'tests': ['dromaeo_dom']}, 18:11:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:11:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:11:06 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:11:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:11:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:11:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:11:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:11:06 INFO - 'tests': ['a11yr', 18:11:06 INFO - 'ts_paint', 18:11:06 INFO - 'tpaint', 18:11:06 INFO - 'sessionrestore', 18:11:06 INFO - 'sessionrestore_no_auto_restore', 18:11:06 INFO - 'tabpaint']}, 18:11:06 INFO - 'other-e10s': {'tests': ['a11yr', 18:11:06 INFO - 'ts_paint', 18:11:06 INFO - 'tpaint', 18:11:06 INFO - 'sessionrestore', 18:11:06 INFO - 'sessionrestore_no_auto_restore', 18:11:06 INFO - 'tabpaint']}, 18:11:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:11:06 INFO - 'ts_paint', 18:11:06 INFO - 'tpaint', 18:11:06 INFO - 'sessionrestore', 18:11:06 INFO - 'sessionrestore_no_auto_restore', 18:11:06 INFO - 'tabpaint']}, 18:11:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:11:06 INFO - 'ts_paint', 18:11:06 INFO - 'tpaint', 18:11:06 INFO - 'sessionrestore', 18:11:06 INFO - 'sessionrestore_no_auto_restore', 18:11:06 INFO - 'tabpaint']}, 18:11:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:11:06 INFO - 'tests': ['a11yr', 18:11:06 INFO - 'ts_paint', 18:11:06 INFO - 'tpaint', 18:11:06 INFO - 'sessionrestore', 18:11:06 INFO - 'sessionrestore_no_auto_restore', 18:11:06 INFO - 'tabpaint']}, 18:11:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:11:06 INFO - 'tests': ['a11yr', 18:11:06 INFO - 'ts_paint', 18:11:06 INFO - 'tpaint', 18:11:06 INFO - 'sessionrestore', 18:11:06 INFO - 'sessionrestore_no_auto_restore', 18:11:06 INFO - 'tabpaint']}, 18:11:06 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:11:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:11:06 INFO - 'bloom_basic_ref']}, 18:11:06 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 18:11:06 INFO - 'talos_options': ['--mitmproxy', 18:11:06 INFO - 'mitmproxy-recording-1.mp', 18:11:06 INFO - '--firstNonBlankPaint'], 18:11:06 INFO - 'tests': ['Quantum_1']}, 18:11:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:11:06 INFO - 'tests': ['tsvgx', 18:11:06 INFO - 'tsvgr_opacity', 18:11:06 INFO - 'tart', 18:11:06 INFO - 'tscrollx', 18:11:06 INFO - 'cart', 18:11:06 INFO - 'tsvg_static']}, 18:11:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:11:06 INFO - 'tsvgr_opacity', 18:11:06 INFO - 'tart', 18:11:06 INFO - 'tscrollx', 18:11:06 INFO - 'cart', 18:11:06 INFO - 'tsvg_static']}, 18:11:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:11:06 INFO - 'talos_options': ['--disable-e10s'], 18:11:06 INFO - 'tests': ['tp5o']}, 18:11:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:11:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:11:06 INFO - 'talos_options': ['--disable-e10s', 18:11:06 INFO - '--xperf_path', 18:11:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:11:06 INFO - 'tests': ['tp5n']}, 18:11:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:11:06 INFO - 'talos_options': ['--xperf_path', 18:11:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:11:06 INFO - 'tests': ['tp5n']}}, 18:11:06 INFO - 'talos.zip': {'path': '', 18:11:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:11:06 INFO - Running post-action listener: _resource_record_post_action 18:11:06 INFO - [mozharness: 2017-05-31 01:11:06.068887Z] Finished populate-webroot step (success) 18:11:06 INFO - [mozharness: 2017-05-31 01:11:06.068981Z] Running create-virtualenv step. 18:11:06 INFO - Running pre-action listener: _resource_record_pre_action 18:11:06 INFO - Running main action method: create_virtualenv 18:11:06 INFO - Creating virtualenv /builds/slave/test/build/venv 18:11:06 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 18:11:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:11:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:11:06 INFO - Using real prefix '/usr' 18:11:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:11:06 INFO - Installing distribute.............................................................................................................................................................................................done. 18:11:08 INFO - Installing pip.................done. 18:11:08 INFO - Return code: 0 18:11:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:11:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:11:08 INFO - Reading from file tmpfile_stdout 18:11:08 INFO - Output received: 18:11:08 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) 18:11:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:11:08 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')]} 18:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:08 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')]} 18:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x16003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b840>, '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 0x197c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cbd0>, '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': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', '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 18:11:08 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 18:11:08 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 18:11:08 INFO - Using env: {'DISPLAY': ':0', 18:11:08 INFO - 'HOME': '/home/cltbld', 18:11:08 INFO - 'LANG': 'en_US.UTF-8', 18:11:08 INFO - 'LANGUAGE': 'en_US:en', 18:11:08 INFO - 'LOGNAME': 'cltbld', 18:11:08 INFO - 'MAIL': '/var/mail/cltbld', 18:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:08 INFO - 'MOZ_NO_REMOTE': '1', 18:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:08 INFO - 'NO_EM_RESTART': '1', 18:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:08 INFO - 'PWD': '/builds/slave/test', 18:11:08 INFO - 'SHELL': '/bin/bash', 18:11:08 INFO - 'SHLVL': '1', 18:11:08 INFO - 'TERM': 'linux', 18:11:08 INFO - 'TMOUT': '86400', 18:11:08 INFO - 'USER': 'cltbld', 18:11:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', 18:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:08 INFO - '_': '/tools/buildbot/bin/python'} 18:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:09 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 18:11:09 INFO - Cleaning up... 18:11:09 INFO - Return code: 0 18:11:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:11:09 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')]} 18:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:09 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')]} 18:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:09 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 0x16003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b840>, '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 0x197c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cbd0>, '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': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', '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 18:11:09 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 18:11:09 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 18:11:09 INFO - Using env: {'DISPLAY': ':0', 18:11:09 INFO - 'HOME': '/home/cltbld', 18:11:09 INFO - 'LANG': 'en_US.UTF-8', 18:11:09 INFO - 'LANGUAGE': 'en_US:en', 18:11:09 INFO - 'LOGNAME': 'cltbld', 18:11:09 INFO - 'MAIL': '/var/mail/cltbld', 18:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:09 INFO - 'MOZ_NO_REMOTE': '1', 18:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:09 INFO - 'NO_EM_RESTART': '1', 18:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:09 INFO - 'PWD': '/builds/slave/test', 18:11:09 INFO - 'SHELL': '/bin/bash', 18:11:09 INFO - 'SHLVL': '1', 18:11:09 INFO - 'TERM': 'linux', 18:11:09 INFO - 'TMOUT': '86400', 18:11:09 INFO - 'USER': 'cltbld', 18:11:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', 18:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:09 INFO - '_': '/tools/buildbot/bin/python'} 18:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:09 INFO - Downloading/unpacking psutil>=3.1.1 18:11:09 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 18:11:09 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 18:11:09 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 18:11:09 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 18:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:11:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:10 INFO - Installing collected packages: psutil 18:11:10 INFO - Running setup.py install for psutil 18:11:10 INFO - building 'psutil._psutil_linux' extension 18:11:10 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 18:11:10 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 18:11:10 INFO - building 'psutil._psutil_posix' extension 18:11:10 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 18:11:10 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 18:11:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:10 INFO - Successfully installed psutil 18:11:10 INFO - Cleaning up... 18:11:11 INFO - Return code: 0 18:11:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:11:11 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')]} 18:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:11 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')]} 18:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:11 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 0x16003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b840>, '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 0x197c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cbd0>, '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': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', '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 18:11:11 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 18:11:11 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 18:11:11 INFO - Using env: {'DISPLAY': ':0', 18:11:11 INFO - 'HOME': '/home/cltbld', 18:11:11 INFO - 'LANG': 'en_US.UTF-8', 18:11:11 INFO - 'LANGUAGE': 'en_US:en', 18:11:11 INFO - 'LOGNAME': 'cltbld', 18:11:11 INFO - 'MAIL': '/var/mail/cltbld', 18:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:11 INFO - 'MOZ_NO_REMOTE': '1', 18:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:11 INFO - 'NO_EM_RESTART': '1', 18:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:11 INFO - 'PWD': '/builds/slave/test', 18:11:11 INFO - 'SHELL': '/bin/bash', 18:11:11 INFO - 'SHLVL': '1', 18:11:11 INFO - 'TERM': 'linux', 18:11:11 INFO - 'TMOUT': '86400', 18:11:11 INFO - 'USER': 'cltbld', 18:11:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', 18:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:11 INFO - '_': '/tools/buildbot/bin/python'} 18:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:11:11 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 18:11:11 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 18:11:11 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 18:11:11 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 18:11:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:11:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:11:12 INFO - Installing collected packages: mozsystemmonitor 18:11:12 INFO - Running setup.py install for mozsystemmonitor 18:11:12 INFO - Successfully installed mozsystemmonitor 18:11:12 INFO - Cleaning up... 18:11:12 INFO - Return code: 0 18:11:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:11:12 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')]} 18:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:12 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')]} 18:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:12 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 0x16003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b840>, '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 0x197c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cbd0>, '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': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', '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 18:11:12 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 18:11:12 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 18:11:12 INFO - Using env: {'DISPLAY': ':0', 18:11:12 INFO - 'HOME': '/home/cltbld', 18:11:12 INFO - 'LANG': 'en_US.UTF-8', 18:11:12 INFO - 'LANGUAGE': 'en_US:en', 18:11:12 INFO - 'LOGNAME': 'cltbld', 18:11:12 INFO - 'MAIL': '/var/mail/cltbld', 18:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:12 INFO - 'MOZ_NO_REMOTE': '1', 18:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:12 INFO - 'NO_EM_RESTART': '1', 18:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:12 INFO - 'PWD': '/builds/slave/test', 18:11:12 INFO - 'SHELL': '/bin/bash', 18:11:12 INFO - 'SHLVL': '1', 18:11:12 INFO - 'TERM': 'linux', 18:11:12 INFO - 'TMOUT': '86400', 18:11:12 INFO - 'USER': 'cltbld', 18:11:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', 18:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:12 INFO - '_': '/tools/buildbot/bin/python'} 18:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:12 INFO - Downloading/unpacking jsonschema==2.5.1 18:11:12 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 18:11:12 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 18:11:12 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 18:11:12 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 18:11:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:11:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:13 INFO - Downloading functools32-3.2.3-2.tar.gz 18:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:11:13 INFO - warning: no files found matching '*.txt' 18:11:13 INFO - no previously-included directories found matching 'build' 18:11:13 INFO - no previously-included directories found matching 'dist' 18:11:13 INFO - no previously-included directories found matching '.git*' 18:11:14 INFO - Installing collected packages: jsonschema, functools32 18:11:14 INFO - Running setup.py install for functools32 18:11:14 INFO - warning: no files found matching '*.txt' 18:11:14 INFO - no previously-included directories found matching 'build' 18:11:14 INFO - no previously-included directories found matching 'dist' 18:11:14 INFO - no previously-included directories found matching '.git*' 18:11:14 INFO - Successfully installed jsonschema functools32 18:11:14 INFO - Cleaning up... 18:11:14 INFO - Return code: 0 18:11:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:11:14 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')]} 18:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:14 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')]} 18:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:14 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 0x16003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b840>, '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 0x197c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cbd0>, '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': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', '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 18:11:14 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 18:11:14 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 18:11:14 INFO - Using env: {'DISPLAY': ':0', 18:11:14 INFO - 'HOME': '/home/cltbld', 18:11:14 INFO - 'LANG': 'en_US.UTF-8', 18:11:14 INFO - 'LANGUAGE': 'en_US:en', 18:11:14 INFO - 'LOGNAME': 'cltbld', 18:11:14 INFO - 'MAIL': '/var/mail/cltbld', 18:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:14 INFO - 'MOZ_NO_REMOTE': '1', 18:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:14 INFO - 'NO_EM_RESTART': '1', 18:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:14 INFO - 'PWD': '/builds/slave/test', 18:11:14 INFO - 'SHELL': '/bin/bash', 18:11:14 INFO - 'SHLVL': '1', 18:11:14 INFO - 'TERM': 'linux', 18:11:14 INFO - 'TMOUT': '86400', 18:11:14 INFO - 'USER': 'cltbld', 18:11:14 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', 18:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:14 INFO - '_': '/tools/buildbot/bin/python'} 18:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:11:14 INFO - Cleaning up... 18:11:14 INFO - Return code: 0 18:11:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:11:14 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')]} 18:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:14 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')]} 18:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:14 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 0x16003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b840>, '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 0x197c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cbd0>, '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': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', '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 18:11:14 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 18:11:14 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 18:11:14 INFO - Using env: {'DISPLAY': ':0', 18:11:14 INFO - 'HOME': '/home/cltbld', 18:11:14 INFO - 'LANG': 'en_US.UTF-8', 18:11:14 INFO - 'LANGUAGE': 'en_US:en', 18:11:14 INFO - 'LOGNAME': 'cltbld', 18:11:14 INFO - 'MAIL': '/var/mail/cltbld', 18:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:14 INFO - 'MOZ_NO_REMOTE': '1', 18:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:14 INFO - 'NO_EM_RESTART': '1', 18:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:14 INFO - 'PWD': '/builds/slave/test', 18:11:14 INFO - 'SHELL': '/bin/bash', 18:11:14 INFO - 'SHLVL': '1', 18:11:14 INFO - 'TERM': 'linux', 18:11:14 INFO - 'TMOUT': '86400', 18:11:14 INFO - 'USER': 'cltbld', 18:11:14 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', 18:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:14 INFO - '_': '/tools/buildbot/bin/python'} 18:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:14 INFO - Downloading/unpacking blobuploader==1.2.4 18:11:14 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 18:11:14 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 18:11:14 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 18:11:14 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 18:11:15 INFO - Downloading blobuploader-1.2.4.tar.gz 18:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:11:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:11:15 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 18:11:15 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 18:11:15 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 18:11:15 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 18:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:11:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:16 INFO - Downloading docopt-0.6.1.tar.gz 18:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:11:16 INFO - Installing collected packages: blobuploader, requests, docopt 18:11:16 INFO - Running setup.py install for blobuploader 18:11:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:11:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:11:16 INFO - Running setup.py install for requests 18:11:16 INFO - Running setup.py install for docopt 18:11:16 INFO - Successfully installed blobuploader requests docopt 18:11:16 INFO - Cleaning up... 18:11:16 INFO - Return code: 0 18:11:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11:16 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')]} 18:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:16 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')]} 18:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:16 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 0x16003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b840>, '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 0x197c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cbd0>, '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': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', '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 18:11:16 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 18:11:16 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 18:11:16 INFO - Using env: {'DISPLAY': ':0', 18:11:16 INFO - 'HOME': '/home/cltbld', 18:11:16 INFO - 'LANG': 'en_US.UTF-8', 18:11:16 INFO - 'LANGUAGE': 'en_US:en', 18:11:16 INFO - 'LOGNAME': 'cltbld', 18:11:16 INFO - 'MAIL': '/var/mail/cltbld', 18:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:16 INFO - 'MOZ_NO_REMOTE': '1', 18:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:16 INFO - 'NO_EM_RESTART': '1', 18:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:16 INFO - 'PWD': '/builds/slave/test', 18:11:16 INFO - 'SHELL': '/bin/bash', 18:11:16 INFO - 'SHLVL': '1', 18:11:16 INFO - 'TERM': 'linux', 18:11:16 INFO - 'TMOUT': '86400', 18:11:16 INFO - 'USER': 'cltbld', 18:11:16 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', 18:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:16 INFO - '_': '/tools/buildbot/bin/python'} 18:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:11:17 INFO - Running setup.py (path:/tmp/pip-CDYSXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:11:17 INFO - Running setup.py (path:/tmp/pip-5USH8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:11:17 INFO - Running setup.py (path:/tmp/pip-RJBUYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:11:17 INFO - Running setup.py (path:/tmp/pip-tl0pbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:11:17 INFO - Running setup.py (path:/tmp/pip-VZdO6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:11:17 INFO - Running setup.py (path:/tmp/pip-m0UF0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:11:17 INFO - Running setup.py (path:/tmp/pip-IZJd7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:11:17 INFO - Running setup.py (path:/tmp/pip-XGzh1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:11:17 INFO - Running setup.py (path:/tmp/pip-Gd39xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:11:17 INFO - Running setup.py (path:/tmp/pip-WiyUMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:11:17 INFO - Running setup.py (path:/tmp/pip-H4JylP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:11:17 INFO - Running setup.py (path:/tmp/pip-nrTx9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:11:17 INFO - Running setup.py (path:/tmp/pip-l0ZhWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:11:18 INFO - Running setup.py (path:/tmp/pip-kyzqol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:18 INFO - Running setup.py (path:/tmp/pip-2xtmds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:11:18 INFO - Running setup.py (path:/tmp/pip-i5GTFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:11:18 INFO - Running setup.py (path:/tmp/pip-b9fotj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:11:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:11:18 INFO - Running setup.py install for manifestparser 18:11:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:11:18 INFO - Running setup.py install for mozcrash 18:11:18 INFO - Running setup.py install for mozdebug 18:11:18 INFO - Running setup.py install for mozdevice 18:11:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:11:18 INFO - Running setup.py install for mozfile 18:11:18 INFO - Running setup.py install for mozhttpd 18:11:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:11:18 INFO - Running setup.py install for mozinfo 18:11:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:11:19 INFO - Running setup.py install for mozInstall 18:11:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:11:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:11:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:11:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:11:19 INFO - Running setup.py install for mozleak 18:11:19 INFO - Running setup.py install for mozlog 18:11:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:11:19 INFO - Running setup.py install for moznetwork 18:11:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:11:19 INFO - Running setup.py install for mozprocess 18:11:19 INFO - Running setup.py install for mozprofile 18:11:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:11:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:11:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:11:19 INFO - Running setup.py install for mozrunner 18:11:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:11:19 INFO - Running setup.py install for mozscreenshot 18:11:19 INFO - Running setup.py install for moztest 18:11:20 INFO - Running setup.py install for mozversion 18:11:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:11:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:11:20 INFO - Cleaning up... 18:11:20 INFO - Return code: 0 18:11:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11: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')]} 18:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11: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')]} 18:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:20 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 0x16003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b840>, '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 0x197c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cbd0>, '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': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', '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 18:11:20 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 18:11:20 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 18:11:20 INFO - Using env: {'DISPLAY': ':0', 18:11:20 INFO - 'HOME': '/home/cltbld', 18:11:20 INFO - 'LANG': 'en_US.UTF-8', 18:11:20 INFO - 'LANGUAGE': 'en_US:en', 18:11:20 INFO - 'LOGNAME': 'cltbld', 18:11:20 INFO - 'MAIL': '/var/mail/cltbld', 18:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:20 INFO - 'MOZ_NO_REMOTE': '1', 18:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:20 INFO - 'NO_EM_RESTART': '1', 18:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:20 INFO - 'PWD': '/builds/slave/test', 18:11:20 INFO - 'SHELL': '/bin/bash', 18:11:20 INFO - 'SHLVL': '1', 18:11:20 INFO - 'TERM': 'linux', 18:11:20 INFO - 'TMOUT': '86400', 18:11:20 INFO - 'USER': 'cltbld', 18:11:20 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', 18:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:20 INFO - '_': '/tools/buildbot/bin/python'} 18:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:11:20 INFO - Running setup.py (path:/tmp/pip-vAgkZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:11:20 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)) 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:11:20 INFO - Running setup.py (path:/tmp/pip-68D3NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:11:20 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)) 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:11:20 INFO - Running setup.py (path:/tmp/pip-kZLc8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:11:20 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)) 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:11:20 INFO - Running setup.py (path:/tmp/pip-22Tzbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:11:20 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)) 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:11:20 INFO - Running setup.py (path:/tmp/pip-LKxjFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:11:20 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)) 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:11:20 INFO - Running setup.py (path:/tmp/pip-GSX8R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:11:20 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)) 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:11:20 INFO - Running setup.py (path:/tmp/pip-YD_D4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:11:20 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)) 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:11:20 INFO - Running setup.py (path:/tmp/pip-KvDIaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:11:20 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)) 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:11:20 INFO - Running setup.py (path:/tmp/pip-U56flb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:11:20 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)) 18:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:11:20 INFO - Running setup.py (path:/tmp/pip-3yIKE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:11:21 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)) 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:11:21 INFO - Running setup.py (path:/tmp/pip-GwK45J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:11:21 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)) 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:11:21 INFO - Running setup.py (path:/tmp/pip-LSSwtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:11:21 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)) 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:11:21 INFO - Running setup.py (path:/tmp/pip-_4zUtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:11:21 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)) 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:11:21 INFO - Running setup.py (path:/tmp/pip-Pr0F70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:11:21 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)) 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:21 INFO - Running setup.py (path:/tmp/pip-M1ZAoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:21 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)) 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:11:21 INFO - Running setup.py (path:/tmp/pip-kwf_hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:11:21 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)) 18:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:11:21 INFO - Running setup.py (path:/tmp/pip-uB6a89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:11:21 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)) 18:11:21 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)) 18:11:21 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)) 18:11:21 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)) 18:11:21 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)) 18:11:21 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)) 18:11:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:11:21 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 18:11:21 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 18:11:21 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 18:11:21 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 18:11:22 INFO - Downloading blessings-1.6.tar.gz 18:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:11:22 INFO - Installing collected packages: blessings 18:11:22 INFO - Running setup.py install for blessings 18:11:22 INFO - Successfully installed blessings 18:11:22 INFO - Cleaning up... 18:11:22 INFO - Return code: 0 18:11:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:11:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:11:23 INFO - Reading from file tmpfile_stdout 18:11:23 INFO - Current package versions: 18:11:23 INFO - argparse == 1.2.1 18:11:23 INFO - blessings == 1.6 18:11:23 INFO - blobuploader == 1.2.4 18:11:23 INFO - docopt == 0.6.1 18:11:23 INFO - functools32 == 3.2.3-2 18:11:23 INFO - jsonschema == 2.5.1 18:11:23 INFO - manifestparser == 1.1 18:11:23 INFO - mozInstall == 1.12 18:11:23 INFO - mozcrash == 1.0 18:11:23 INFO - mozdebug == 0.1 18:11:23 INFO - mozdevice == 0.51 18:11:23 INFO - mozfile == 1.2 18:11:23 INFO - mozhttpd == 0.7 18:11:23 INFO - mozinfo == 0.9 18:11:23 INFO - mozleak == 0.1 18:11:23 INFO - mozlog == 3.4 18:11:23 INFO - moznetwork == 0.27 18:11:23 INFO - mozprocess == 0.25 18:11:23 INFO - mozprofile == 0.28 18:11:23 INFO - mozrunner == 6.13 18:11:23 INFO - mozscreenshot == 0.1 18:11:23 INFO - mozsystemmonitor == 0.3 18:11:23 INFO - moztest == 0.8 18:11:23 INFO - mozversion == 1.4 18:11:23 INFO - psutil == 3.1.1 18:11:23 INFO - requests == 1.2.3 18:11:23 INFO - wsgiref == 0.1.2 18:11:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11: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')]} 18:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11: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')]} 18:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:23 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 0x16003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b840>, '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 0x197c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cbd0>, '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': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', '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 18:11:23 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 18:11:23 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 18:11:23 INFO - Using env: {'DISPLAY': ':0', 18:11:23 INFO - 'HOME': '/home/cltbld', 18:11:23 INFO - 'LANG': 'en_US.UTF-8', 18:11:23 INFO - 'LANGUAGE': 'en_US:en', 18:11:23 INFO - 'LOGNAME': 'cltbld', 18:11:23 INFO - 'MAIL': '/var/mail/cltbld', 18:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:23 INFO - 'MOZ_NO_REMOTE': '1', 18:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:23 INFO - 'NO_EM_RESTART': '1', 18:11:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:23 INFO - 'PWD': '/builds/slave/test', 18:11:23 INFO - 'SHELL': '/bin/bash', 18:11:23 INFO - 'SHLVL': '1', 18:11:23 INFO - 'TERM': 'linux', 18:11:23 INFO - 'TMOUT': '86400', 18:11:23 INFO - 'USER': 'cltbld', 18:11:23 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', 18:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:23 INFO - '_': '/tools/buildbot/bin/python'} 18:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:23 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)) 18:11:23 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)) 18:11:23 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)) 18:11:23 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)) 18:11:23 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)) 18:11:23 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)) 18:11:23 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)) 18:11:23 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)) 18:11:23 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)) 18:11:23 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:11: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 18:11: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 18:11: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 18:11: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 18:11:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:11:24 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)) 18:11:24 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)) 18:11:24 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)) 18:11:24 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)) 18:11:24 INFO - Installing collected packages: marionette-driver 18:11:24 INFO - Running setup.py install for marionette-driver 18:11:24 INFO - Successfully installed marionette-driver 18:11:24 INFO - Cleaning up... 18:11:24 INFO - Return code: 0 18:11:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:11:24 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')]} 18:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:24 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')]} 18:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:24 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 0x16003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b840>, '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 0x197c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cbd0>, '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': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', '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 18:11:24 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 18:11:24 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 18:11:24 INFO - Using env: {'DISPLAY': ':0', 18:11:24 INFO - 'HOME': '/home/cltbld', 18:11:24 INFO - 'LANG': 'en_US.UTF-8', 18:11:24 INFO - 'LANGUAGE': 'en_US:en', 18:11:24 INFO - 'LOGNAME': 'cltbld', 18:11:24 INFO - 'MAIL': '/var/mail/cltbld', 18:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:24 INFO - 'MOZ_NO_REMOTE': '1', 18:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:24 INFO - 'NO_EM_RESTART': '1', 18:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:24 INFO - 'PWD': '/builds/slave/test', 18:11:24 INFO - 'SHELL': '/bin/bash', 18:11:24 INFO - 'SHLVL': '1', 18:11:24 INFO - 'TERM': 'linux', 18:11:24 INFO - 'TMOUT': '86400', 18:11:24 INFO - 'USER': 'cltbld', 18:11:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', 18:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:24 INFO - '_': '/tools/buildbot/bin/python'} 18:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:11:24 INFO - Cleaning up... 18:11:24 INFO - Return code: 0 18:11:24 INFO - Running post-action listener: _resource_record_post_action 18:11:24 INFO - Running post-action listener: _start_resource_monitoring 18:11:24 INFO - Starting resource monitoring. 18:11:24 INFO - [mozharness: 2017-05-31 01:11:24.898375Z] Finished create-virtualenv step (success) 18:11:24 INFO - [mozharness: 2017-05-31 01:11:24.898851Z] Running install step. 18:11:24 INFO - Running pre-action listener: _resource_record_pre_action 18:11:24 INFO - Running main action method: install 18:11:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:11:25 INFO - Reading from file tmpfile_stdout 18:11:25 INFO - Detecting whether we're running mozinstall >=1.0... 18:11:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:11:25 INFO - Reading from file tmpfile_stdout 18:11:25 INFO - Output received: 18:11:25 INFO - Usage: mozinstall [options] installer 18:11:25 INFO - Options: 18:11:25 INFO - -h, --help show this help message and exit 18:11:25 INFO - -d DEST, --destination=DEST 18:11:25 INFO - Directory to install application into. [default: 18:11:25 INFO - "/builds/slave/test"] 18:11:25 INFO - --app=APP Application being installed. [default: firefox] 18:11:25 INFO - mkdir: /builds/slave/test/build/application 18:11:25 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'] 18:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:11:41 INFO - Reading from file tmpfile_stdout 18:11:41 INFO - Output received: 18:11:41 INFO - /builds/slave/test/build/application/firefox/firefox 18:11:41 INFO - Running post-action listener: _resource_record_post_action 18:11:41 INFO - [mozharness: 2017-05-31 01:11:41.265171Z] Finished install step (success) 18:11:41 INFO - [mozharness: 2017-05-31 01:11:41.265413Z] Running setup-mitmproxy step. 18:11:41 INFO - Running pre-action listener: _resource_record_pre_action 18:11:41 INFO - Running main action method: setup_mitmproxy 18:11:41 INFO - Skipping: mitmproxy is not required 18:11:41 INFO - Running post-action listener: _resource_record_post_action 18:11:41 INFO - [mozharness: 2017-05-31 01:11:41.265943Z] Finished setup-mitmproxy step (success) 18:11:41 INFO - [mozharness: 2017-05-31 01:11:41.266049Z] Running run-tests step. 18:11:41 INFO - Running pre-action listener: _resource_record_pre_action 18:11:41 INFO - Running main action method: run_tests 18:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:11:41 INFO - Python 2.7.3 18:11:41 INFO - Return code: 0 18:11:41 INFO - grabbing minidump binary from tooltool 18:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:41 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 0x197b840>, '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 0x197c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cbd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:11:41 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 18:11:41 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 18:11:41 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 18:11:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:11:41 INFO - Return code: 0 18:11:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:11:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:11:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:11:41 INFO - ENV: RUST_BACKTRACE is now 1 18:11:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:11:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:11:41 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/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 18:11:41 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/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 18:11:41 INFO - Using env: {'DISPLAY': ':0', 18:11:41 INFO - 'HOME': '/home/cltbld', 18:11:41 INFO - 'LANG': 'en_US.UTF-8', 18:11:41 INFO - 'LANGUAGE': 'en_US:en', 18:11:41 INFO - 'LOGNAME': 'cltbld', 18:11:41 INFO - 'MAIL': '/var/mail/cltbld', 18:11:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:11:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:41 INFO - 'MOZ_NO_REMOTE': '1', 18:11:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:41 INFO - 'NO_EM_RESTART': '1', 18:11:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:41 INFO - 'PWD': '/builds/slave/test', 18:11:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:11:41 INFO - 'RUST_BACKTRACE': '1', 18:11:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:11:41 INFO - 'SHELL': '/bin/bash', 18:11:41 INFO - 'SHLVL': '1', 18:11:41 INFO - 'TERM': 'linux', 18:11:41 INFO - 'TMOUT': '86400', 18:11:41 INFO - 'USER': 'cltbld', 18:11:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009', 18:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:41 INFO - '_': '/tools/buildbot/bin/python'} 18:11:41 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/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 18:11:41 INFO - mozversion application_buildid: 20170531002746 18:11:41 INFO - mozversion application_changeset: 5b2c84104a7f4774fd120ab38d21b6483bcb63c7 18:11:41 INFO - mozversion application_display_name: Nightly 18:11:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:11:41 INFO - mozversion application_name: Firefox 18:11:41 INFO - mozversion application_remotingname: firefox 18:11:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:11:41 INFO - mozversion application_vendor: Mozilla 18:11:41 INFO - mozversion application_version: 55.0a1 18:11:41 INFO - mozversion platform_buildid: 20170531002746 18:11:41 INFO - mozversion platform_changeset: 5b2c84104a7f4774fd120ab38d21b6483bcb63c7 18:11:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:11:41 INFO - mozversion platform_version: 55.0a1 18:11:41 INFO - using testdate: 1496193101 18:11:41 INFO - actual date: 1496193101 18:11:41 INFO - starting webserver on 'localhost:59200' 18:11:41 INFO - SUITE-START | Running 2 tests 18:11:41 INFO - TEST-START | dromaeo_css 18:11:41 INFO - operating with platform_type : linux_ 18:11:41 INFO - Initialising browser for dromaeo_css test... 18:11:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59200/getInfo.html -profile /tmp/tmprsWULf/profile 18:11:41 INFO - TEST-INFO | started process 20335 (/builds/slave/test/build/application/firefox/firefox http://localhost:59200/getInfo.html) 18:12:16 INFO - TEST-INFO | 20335: killed by SIGTERM 18:12:17 INFO - Browser initialized. 18:12:17 INFO - Running cycle 1/1 for dromaeo_css test... 18:12:17 INFO - TEST-INFO | started process 20557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprsWULf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:12:28 INFO - PID 20557 | RSS: Main: 187441152 18:12:28 INFO - PID 20557 | 18:15:33 INFO - PID 20557 | Cycle 1(1): loaded http://localhost:59200/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59200/tests/dromaeo/cssquery-ext.html) 18:15:35 INFO - PID 20557 | RSS: Main: 184213504 18:15:35 INFO - PID 20557 | 18:18:37 INFO - PID 20557 | Cycle 1(1): loaded http://localhost:59200/tests/dromaeo/cssquery-ext.html (next: http://localhost:59200/tests/dromaeo/cssquery-jquery.html) 18:18:38 INFO - PID 20557 | RSS: Main: 188321792 18:18:38 INFO - PID 20557 | 18:21:39 INFO - PID 20557 | Cycle 1(1): loaded http://localhost:59200/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59200/tests/dromaeo/cssquery-mootools.html) 18:21:40 INFO - PID 20557 | RSS: Main: 185782272 18:21:40 INFO - PID 20557 | 18:24:42 INFO - PID 20557 | Cycle 1(1): loaded http://localhost:59200/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59200/tests/dromaeo/cssquery-prototype.html) 18:24:42 INFO - PID 20557 | RSS: Main: 189157376 18:24:42 INFO - PID 20557 | 18:27:45 INFO - PID 20557 | Cycle 1(1): loaded http://localhost:59200/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59200/tests/dromaeo/cssquery-yui.html) 18:27:46 INFO - PID 20557 | RSS: Main: 187277312 18:27:46 INFO - PID 20557 | 18:30:48 INFO - PID 20557 | Cycle 1(1): loaded http://localhost:59200/tests/dromaeo/cssquery-yui.html (next: http://localhost:59200/tests/dromaeo/cssquery-dojo.html) 18:30:48 INFO - PID 20557 | RSS: Main: 184774656 18:30:48 INFO - PID 20557 | 18:30:48 INFO - PID 20557 | __start_tp_report 18:30:48 INFO - PID 20557 | _x_x_mozilla_page_load 18:30:48 INFO - PID 20557 | _x_x_mozilla_page_load_details 18:30:48 INFO - PID 20557 | |i|pagename|runs| 18:30:48 INFO - PID 20557 | |0;dojo.html;2750.3811642380465;2767.695553489117;2790.35821760995;2794.972050279497;2795.0915952315504;5144.614153938451;5296.073187192241;5302.681839089652;5356.54469370104;5358.196270559413;5197.194434862602;5265.104932161532;5267.52592266696;5310.0972834618115;5354.598405119622;4699.812007519695;4709.646776491777;4734.337192793012;4746.406699162605;4776.785044672998;4705.106029854333;4728.290756386536;4798.592119669832;4800.255960326155;4838.564529192372;4596.770161491912;4653.255479123324;4722.76386180693;4724.881877953045;4801.399825021872;4658.208104622222;4747.952520474785;4748.738819364934;4773.665843390964;4793.952060479421;4686.437627484724;4707.411573553306;4709.293605959099;4715.198416269208;4736.550027747358;5147.0992576298995;5233.633645644806;5248.291480650101;5299.2845965794895;5355.571554275649;5665.631733937322;5672.68800215988;5729.512991395736;5753;5786.334571524287;5775.682337471438;5791.768329266824;5792.768289268424;5807.738651760681;5812;5346.1713434417725;5347.117725575236;5358.758855851457;5370.677759334452;5371.409144994048;5750.712464376765;5775.537956963432;5826.970865145732;5849.590528663038;5850.502707269845;5666.2350582670815;5678.886422271531;5702.0591602385975;5705.343885453143;5729.713514324267;5675.460831221028;5737.88524229513;5745.511631511285;5761.193432919395;5764.106563482667;5493.862653433696;5551.25058117149;5709.314882214161;5723.027085395493;5727.5131613812455;5588.9720551397795;5611.915821262684;5693.146028095819;5734.799282025109;5735.799247026417;4758.333833263346;4780.163471392492;4780.426348838162;4791.784369703371;4841.346418233564;4079.755214687128;4087.8978025549004;4095.836166553364;4112.321466957918;4141.109661422808;4712.363830882787;4784.162771514971;4788.138135135709;4814.807407703653;4858.514148585114;5728.312602487645;5729.0260655688635;5745.712714364265;5784.074548072288;5805.535557155417;4793.400824896888;4815.277708343707;4819.975900120477;4829.541193586604;4852.17513022787;4968.701877887338;5047.116754567863;5102.3877134743325;5119.129747942859;5120.92318615221;5243.895122097613;5293.841184764463;5322.680639161663;5337.599680024091;5339.866503337447;5567.749451274622;5660.915086273627;5710.314762228559;5732.770689172553;5737.110747834093;5193.896122077613;5212.452692467236;5232.424433312256;5238.764255608583;5337.306150200449;5662.716864156858;5664.0371136906;5667.4332566743;5683.8010669626365;5713.685747283939;5618.606697531133;5619.831405057855;5711.3431955324;5747.051736463437;5773.364929857628;5563.693996830213;5578.219049333178;5599;5599.80400685974;5614.691191984317;5528.19841123043;5539.362973257966;5561.555075593862;5566.554675625859;5572.60991730575;5353.437889021597;5390.110631745718;5464.9180262296895;5468.644538105011;5518.255035570147;5509.146082357241;5537.916931246115;5546.084895992116;5617.241672374177;5631;5387.838364849061;5393.27190829233;5404.108322126962;5407.7025763581805;5444.128939369682 18:30:48 INFO - PID 20557 | |1;ext.html;595.8867815115128;652.451940370089;665.2216906219722;1078.3314345106035;1092.421016861063;31100.22249443762;31927.521087183683;31969.040928772145;31992;32025.199370015704;30298.545521817134;30908;30963.535546966756;30974;30986.690133098662;6615.503837212204;6765;6771.8984215236815;6775.932240677604;6782.864342713143;6580.868382632344;6604.801855944305;6709.429698475636;6712.899306510406;6718.227403848547;6660.433863121616;6711.966440167792;6734.966325168391;6735.9663201683925;6746.527743057988;6707.429868461187;6709.194896612414;6721.428678562328;6726.932730672728;6729.091572637681;6513.316101809289;6571.342865713438;6578.93421065788;6589.439897608709;6606.768763093269;28771.56842647362;28913.277168070756;28928.421431571252;28950.855245723636;28957.131286061453;2733.2073698627373;2743.5198840203084;2753.752162305402;2759.6412466379443;2761.0750398616487;22643.660345094835;22805;22808.65787013196;22867.085316587316;22880;2924.1227631710613;2943.499605067144;2947.911562653124;2950.601668774731;2957.6155099837097;145308;146035;146035.26982365127;151777;155670.22164889215;34722.30555388878;34922.47616285758;34993;34997.82501087478;35009.474857877154;36086.819565902006;36092.27815443729;36199;38068;38976;10616.044555989998;10629.096526795154;10636.627718029831;10658.081545321762;10695;8369.246767790928;8372.497650141011;8375;8386;8408.159184081544;11230.606928757617;11256.212065155525;11303.1522635801;11426.485808138488;11474.827877581843;4587.7017993830295;4637.582617564435;4706.505816889246;4735.147673418817;4775.808967641256;796.6972550430916;825.2284114353099;826.68999125328;827.5613924619961;837.6816809612309;19366.903165484084;19852.90073549623;20057.598848022957;20099.49751256201;20256.088476018616;885.2210055151426;886.9822603547893;887.7248053103558;898.1557336104172;913.0960349254191;10145.847812282822;10367;10374.27380083387;10452.425116618659;10480.68557943263;182578;183539;183756;184102;185423;36098.097547560996;36339.636603633626;36400.63599364025;36414.8179259102;36466.27067458689;1044.6448207609449;1075.8117329467468;1077.3535878472853;1082.3019152646498;1090.9945450272699;18850;18954.715679264547;19434.12546435442;19668.50828729293;19936;26338;26367;26485.867570662023;26556.46887062209;26570.734292656827;151945;152108.239458802;152296.2385188067;152401;152734.70897936763;26806.865965670047;27032.32419189536;27032.59451108274;27061.39956207489;27125.18624441191;31239.375212496077;31942.423094559523;32178.19554511156;32269.67730322667;32271.193220169684;24641.753582463945;24888.502229955662;25112.74887251104;25171.74828251694;25712;24089.638655419833;24141.63787543153;24500.50998980046;24567.262982110566;25306.28158411702;28346.433071338044;28756.856215718788;28891.42217155603;28952;29083.418331632827;24451.877740611893;25409.87295063513;25523.744762552138;25570;26013.479730405663;20226;20642.17431302731;20869.478263043544;20906.37280881576;20959.580808384053 18:30:48 INFO - PID 20557 | |2;jquery.html;382.2069206396728;385.87073330434305;392.17447273489296;397.5527531527032;412.28674393299593;13051.869481305208;13819.585412437644;16988.150592470374;17605.471835844928;17640.470785876412;16302.83697163028;16972.66054678906;16973.57566060849;16977.49067527973;17014.659706805858;5348.491893270153;5428.212909128174;5475.561955043587;5475.561955043587;5476.3702174249875;5370.43610420906;5442.673439593637;5462.9726851365685;5468.179773034057;5469.07025805614;5395.59533035022;5407.5133238008575;5415.241866138724;5428.809991650293;5445.591580631449;5203.531682148606;5235.319408476893;5284.603654725911;5330.866728331823;5390.865228369283;4806.558032590244;4817.61459083276;4831.22700367943;4832.710037397767;4836.564709176156;20290.79709202904;20504.487387815276;20625.174993000262;20656.380308590768;20700.275490357766;1572.2846105022188;1589.36425429829;1591;1593.6812637472551;1595.1784830812142;13937.163770173822;14004.579862604036;14364.138151710826;14387.640308992255;14472.638184045378;1988.443235893952;2041.7754047054812;2046.8464865135174;2048.5902819436023;2048.72342233798;103662;107446;107724;107837.46081269544;108030;9791.265655075898;10101.545430455648;10277.248804186418;10665.306755060896;10910.945445272722;14391.920605954387;14433.639159021108;14445.92777036108;14454.85545144556;14458;6889.379955804002;7147.928520714726;7171.605561694157;7232.566046037149;7263.455240856957;6557.409833115043;6580.5722628029025;6584.934150658432;6600.471962243009;6644.4020038196795;6442.843006926572;6634.767783127568;6673.299303573152;6676.9332306676315;6681.465482761368;1954.3843689237845;1962.479942815155;1982.1575830272077;1985.5532505186507;2012.2655230840637;757.2541047068632;763.9121501027341;787.7597332813547;791.5883740454931;800.1118758178417;15922.76115858263;16143.434979775651;16283.267252973645;16440.83559164393;16537.751933721003;786.7679034684782;791.639803889229;793.5754371411267;806.1776987472745;814.4746638418187;8707.129287071242;8770.868436973451;8875.423097498642;9053.456792592466;9160.129787670161;359092;361227;361579.02892820165;375040;378268;89855.55072224728;91069;91468;91842.89728129901;91922;917.3165991336364;939.4598106089027;941.5339406993445;945.6264775413673;946.8059047895165;14128.364223609757;14379.712405752036;14530.346134424188;14726.263686815402;15056.774148387563;41972.580274196866;42201.1559768809;42579.7871010643;43732;43834.56165438305;55429;55450;55457;55570.722146390624;55808.72095639496;8865.20213180791;9150.450972941378;9246.445213287225;9254.074592540692;9259.398139120936;13579.728405431639;14706.191159485903;14768.409263629765;15184.544463666107;15362.30869610848;11902.940485297519;11932.701682458008;12053.939730301292;12069.818952715541;13278.668033299246;11776.82334764962;12127.332996685267;12246.510139594673;12362.320072396105;12513.812292815433;12742.235465872078;13079.542216022393;13204.867951320748;13390.397432115384;13399.665008374868;8993.910060899307;8994.730158095268;9060.411073280216;9097.636094556408;9119.772005699911;12020;12175.703568947536;12246.510139594673;12307.692307692021;12353.444095015926 18:30:48 INFO - PID 20557 | |3;mootools.html;1049.1187402581832;1089.907357874581;1099.8295264234046;1103.0899507905979;1111.1832802889874;8986.730398088068;9273.397229180098;9924.20606351492;10379.273450858444;10381.844272335911;9751.366161199518;10159.13647339975;10179.491025448735;10186.949065254663;10204.234682398812;2079.4905248214172;2141.1649456711893;2145.7639659637425;2147.667111597697;2149.7312835895514;1810.8008119106887;1879.736836842843;2033.3290014295246;2077.511784730587;2080.9479763005893;1977.2782934228974;2064.411642681836;2065.380385884229;2071.6063947849934;2074.5332300232476;2072.6580114281123;2099.9475013124643;2108.146200788683;2108.1778106538463;2110.905009274579;2088.3004193595166;2091.989540052305;2105.2947262667026;2107.6522373808302;2114.1332053858;9756.414615123116;9815.411075335503;9945.850812237823;9952.552135153863;9966.451845148515;5267.078261304257;5355.036093503168;5442.455754424565;5444;5448.782048718046;3063.1423201503394;3287.9342413151844;3376.5441665375106;3409.9488507672404;3417.6069751978594;1085.592902661502;1087.6519513755602;1095.1950316517352;1113.604670342025;1116.4417791104447;15483.690326193526;15776.053436793714;15866.286017129258;15900.76148857768;15960;4727.64542659302;4734.124187025412;4912.754362281943;4917.65576409655;4938.530839570235;12174.695632609255;12243.142979991493;12260.509579616715;12273.877261227452;12276.32480213579;5476.616636835463;5487;5492.038893193675;5494.890102198014;5515.889682206413;4865.099956508057;4900.558949694545;4999.925001124986;5008.198688209869;5010.148274793294;3948.4274780156716;4020.979895100506;4081.8775436736946;4085.162541678949;4146.4402305688345;1208.8186771984272;1238.541495132162;1291.063978615515;1303.4590644882458;1328.1566205459603;608.4341562347059;637.3594537489793;650.0509256485584;652.6019128331714;653.5261935097112;5866.178734977107;5911.527077833763;6010.308814486302;6090.786822461193;6122.7550897964475;752.259024860512;762.4357975098387;765.548326487364;767.8195624028349;781.0588241169377;3374.4769560718128;3475.878344257939;3504.229069604683;3534.2401383702113;3575.3743094958277;13652.931735341259;14193;14224.85775142256;14240.359183836545;14251.92874035644;13596.184228946295;13849.446022159202;14034.36845341962;14118.152910825384;14140.080894741808;7146.821329466805;7233.819154521179;7242.818929526804;7247;7292.562446253136;5269.947300526946;5331.626786125089;5394.109971854757;5534.142207957773;5648;12030;12233.388330583257;12242.632721018384;12245.755084898074;12328.260304381765;12738.87261127377;12811.935940320238;12908.225506469642;12984.610461686165;13067.607971760863;7512.661930213263;7645.273698998586;7666.846663066596;7681.923180768121;7682.193369696101;8846.424982376126;9360.344775865897;9490.810183796424;9494.192993595621;9527.237820974167;8078;8099.635516401894;8118.228768267005;8203.466774659628;8209.302209312274;7860.174681658572;7909.960450197712;7916;8027;8055.234752698484;7055.929440705528;7164.355208031302;7168.67740951648;7180.174279957663;7183.928160718535;4899.534544218293;4929.137400954747;4960.107180707508;4972.676776009548;5001.049800537886;4806.399200099988;4886.975565122151;4913.41039075299;4966.379202599675;4991.401031876198 18:30:48 INFO - PID 20557 | |4;prototype.html;342.5067902220802;366.58026559589285;376.65159727252285;380.2679841305486;382.19166462930895;5629.014922388581;5645.774169033239;5663.235463212465;5665.150227465877;5677.536702611404;5518.323613047679;5529.861753456165;5539.473749993744;5539.947409992099;5584.86037849054;4026.3356546169994;4194.328907374821;4302.569743025696;4310.245707001278;4310.719803212797;4175.791210439465;4185.162967406515;4185.28850095483;4198.307279298912;4200.789960501963;4117.300058989964;4134.4831896013;4138.33786594145;4147.8963025924295;4166.062635906927;4136.544980052192;4148.6266236038755;4153.6677065834665;4154.127633197032;4157;3632.637760839685;3643.7995910224927;3645.2891686121216;3646.2889736501393;3646.690031347339;5398.676079435247;5400.83797486076;5411.594130440233;5414.214938833847;5429.267048948421;4887.584555312803;4894.290327902434;4894.755262236874;4908.901821963541;4915.3855768029;5828.854278643025;5830.2420685310635;5838.41615838417;5846.561507886926;5859.150423188614;4070.1045769930865;4070.348744200943;4070.5522392536795;4077.7553346799286;4086.3053280942313;5910.1430292607765;6192.907106393408;6241.096465577997;6243.406876346739;6292.811215663537;4108.938365924513;4141.937870931938;4154.792260386968;4158.854440094582;4170.874873753793;4200.789960501963;4202.537720850704;4205.726627769185;4212.768297743653;4216.093539888939;4665.5567721066445;4811.542903424169;4848.345473361122;4874.707517548958;4883.218685010382;5911.881762364728;5918.319393269829;5918.526517878559;5921.319048309413;5941.108833674897;1424.750668632985;1430.5207755402057;1434.7517659636183;1436.5762100180473;1437.9431118128168;935.9953200233955;970.8495183246467;983.2625530851861;985.7929834734642;986.7631768375538;5061.493850614909;5062.063518249136;5064.4935506449065;5070.29015937769;5073.974630126826;6056.212692349966;6056.66688332146;6092.786752463642;6106.4809491192855;6112.541559383064;5008.69947803133;5019.67372120811;5028.396592408934;5038.697678139323;5055.974720126449;3212.5020621803656;3230.7576931730214;3237.4496335623003;3246.188452886778;3254.9674503254664;5616.326040875121;5637.098064309691;5641.379448260688;5647.181158732043;5655.123455864347;6202.875942481125;6241.937580624226;6268.623882567061;6271.150010746841;6277.623342599459;5609.242752228397;5635.5773317001385;5639.125935480007;5639.351474580394;5647.124695672095;6062.242219722535;6081.6351018939;6092.390760923872;6105.877882442415;6116.633002019893;6012.108134028589;6012.48269762194;6024.8853962017165;6031.396860314109;6040.003399439043;5397;5421.186821976735;5541.259649736492;5545.972270138624;5550.27846379968;4084.3465045593753;4085.3871919212356;4104.199681062164;4104.815283312318;4107.712460127762;6102.755889764538;6112.72492737819;6118.768452972644;6120.816375508742;6135.785247516315;5641.26663533738;5859.882802344015;5865.237519122486;5887.8233652990475;5919.4080591940465;5816.069428891357;5845.041910959876;5846.123081537803;5846.824595262149;5862.677552734641;5787.536997040311;5795.33353664334;5806.274215723035;5820.505257053029;5822.359540450631;5940.61386009908;5969.552283578836;5976.372480889618;5978.192943952511;5979.850503737442;5753.97123014399;5766.913496297475;5778.191053252464;5780.335261444988;5793.681347525927 18:30:48 INFO - PID 20557 | |5;yui.html;620.5966122020689;627.5450298533564;633.8035209085184;645.7804346522181;648.8053583924822;13283.667908302285;13393.732125357486;13445.193288402703;14091.718165636681;16325;14719.926400367984;14973.850261497382;14990.400383984628;15011.84988150121;15012.924935375335;632.014058069412;646.6217262901208;650.0152269311997;652.6084349390352;652.8531080506872;642.5823214910322;655.3675702946656;658.7397977798767;664.7640087768845;670.5071772247394;695.6556504530265;701.2461603775961;701.9821259174192;702.9051078104467;704.2394214248625;703.4372501998432;704.6617623540678;705.9541129826596;707.2997732245092;709.8118998465385;511.9334486516729;512.1805111821094;512.787193314774;517.1983425690203;522.4096770649143;13803.447862085504;13856.30718464083;13875.722485550334;13920.234387108705;13926.51257205993;13958.51145209923;14922.776158357634;14937.327820248114;14942.402303907831;15065.322060507195;12020.51917923282;12227.877721222763;12320.938395308056;12349.753004939941;12405.44175512104;2955.4975654138634;2978.195887110468;2980.508216144334;2983.925401864949;2986.835724035177;73391;74487.62756186184;74574;74662.25337746607;84675.5766221165;11200.831987520194;11496.252743571808;11560.364179970182;11581.942090289494;11651.30092194471;15345.6163595911;15680.607984800472;19469.51326216856;19648.60702785936;20432.59134817325;6013.338532761392;6169.352218017133;6171.814845554641;6185.84535386619;6189.597676151036;2979.4190132924305;3017.4116047370553;3040.9239769005508;3048.4969979953057;3057.8929737459084;3671.57776855665;3794.582595914447;3823.5602905665646;3825.8713679464627;3830.1190726133145;707.3334697337274;722.5231347310855;735.3933005270566;736.7642354446525;736.8378956629533;543.9584577642381;546.7812874850092;559.0245022435794;574.74136638512;575.4015823543551;9628.90371096294;9896.60413583463;10200.540975656113;10572.629957951589;11172.497237624326;572.3503823160743;575.3383608849773;575.5855783835632;577.4023885278716;577.5610535992676;4765.880852978634;4914.311996320518;4919.434265059493;4968.478309777493;5079.568236699848;73519.63240183872;74262.62868685622;74448.25551744521;75497;86339.56830215809;64511;64691.35308646948;65490;66370.00444993233;67909.66045169742;57392.71303643539;58038.7098064507;60821;60949;61415.692921536;9681.951590242004;9827.85258221113;10458.895411045793;10594.258401911793;10662.946685266834;27129.321766955985;27330.590041149797;27425.451490970467;28558.714412855606;29254.70745292605;49285.26072108993;49420.50579494303;51228.74385628048;51875.481245188574;52790;11851.407429628656;12966.481340746264;13536.255505947267;13856.861431385558;14227.288635568388;15117.244137793286;15141.545753627408;15364.846351536342;15487;15756.684866302381;13579.86420135786;13882.305884705522;14462.566123016326;14542.5637230879;14558.781618275523;14500.782488262474;14742.852571474148;15007.249637518298;15116.395344186549;15303.081815091131;13999.370028348952;14259.287035648384;14528.709425811214;14547.709045818812;14605.415783368546;11358.26171298863;11487.655370338904;11786.823197652213;11871;12044.457999389873;12109.212901161396;12153;12563.738527065216;12566.371681416076;12579.93710031444 18:30:48 INFO - PID 20557 | __end_tp_report 18:30:48 INFO - PID 20557 | __start_cc_report 18:30:48 INFO - PID 20557 | _x_x_mozilla_cycle_collect,391 18:30:48 INFO - PID 20557 | __end_cc_report 18:30:48 INFO - PID 20557 | __startTimestamp1496194248820__endTimestamp 18:30:48 INFO - PID 20557 | 18:30:48 INFO - PID 20557 | ------- Summary: start ------- 18:30:48 INFO - PID 20557 | Number of tests: 6 18:30:48 INFO - PID 20557 | 18:30:48 INFO - PID 20557 | [#0] dojo.html Cycles:165 Average:5218.36 Median:5358.20 stddev:611.12 (11.4%) stddev-sans-first:581.52 18:30:48 INFO - PID 20557 | Values: 2750.4 2767.7 2790.4 2795.0 2795.1 5144.6 5296.1 5302.7 5356.5 5358.2 5197.2 5265.1 5267.5 5310.1 5354.6 4699.8 4709.6 4734.3 4746.4 4776.8 4705.1 4728.3 4798.6 4800.3 4838.6 4596.8 4653.3 4722.8 4724.9 4801.4 4658.2 4748.0 4748.7 4773.7 4794.0 4686.4 4707.4 4709.3 4715.2 4736.6 5147.1 5233.6 5248.3 5299.3 5355.6 5665.6 5672.7 5729.5 5753.0 5786.3 5775.7 5791.8 5792.8 5807.7 5812.0 5346.2 5347.1 5358.8 5370.7 5371.4 5750.7 5775.5 5827.0 5849.6 5850.5 5666.2 5678.9 5702.1 5705.3 5729.7 5675.5 5737.9 5745.5 5761.2 5764.1 5493.9 5551.3 5709.3 5723.0 5727.5 5589.0 5611.9 5693.1 5734.8 5735.8 4758.3 4780.2 4780.4 4791.8 4841.3 4079.8 4087.9 4095.8 4112.3 4141.1 4712.4 4784.2 4788.1 4814.8 4858.5 5728.3 5729.0 5745.7 5784.1 5805.5 4793.4 4815.3 4820.0 4829.5 4852.2 4968.7 5047.1 5102.4 5119.1 5120.9 5243.9 5293.8 5322.7 5337.6 5339.9 5567.7 5660.9 5710.3 5732.8 5737.1 5193.9 5212.5 5232.4 5238.8 5337.3 5662.7 5664.0 5667.4 5683.8 5713.7 5618.6 5619.8 5711.3 5747.1 5773.4 5563.7 5578.2 5599.0 5599.8 5614.7 5528.2 5539.4 5561.6 5566.6 5572.6 5353.4 5390.1 5464.9 5468.6 5518.3 5509.1 5537.9 5546.1 5617.2 5631.0 5387.8 5393.3 5404.1 5407.7 5444.1 18:30:48 INFO - PID 20557 | 18:30:48 INFO - PID 20557 | [#1] ext.html Cycles:180 Average:29035.28 Median:28902.35 stddev:41998.14 (145.3%) stddev-sans-first:42061.66 18:30:48 INFO - PID 20557 | Values: 595.9 652.5 665.2 1078.3 1092.4 31100.2 31927.5 31969.0 31992.0 32025.2 30298.5 30908.0 30963.5 30974.0 30986.7 6615.5 6765.0 6771.9 6775.9 6782.9 6580.9 6604.8 6709.4 6712.9 6718.2 6660.4 6712.0 6735.0 6736.0 6746.5 6707.4 6709.2 6721.4 6726.9 6729.1 6513.3 6571.3 6578.9 6589.4 6606.8 28771.6 28913.3 28928.4 28950.9 28957.1 2733.2 2743.5 2753.8 2759.6 2761.1 22643.7 22805.0 22808.7 22867.1 22880.0 2924.1 2943.5 2947.9 2950.6 2957.6 145308.0 146035.0 146035.3 151777.0 155670.2 34722.3 34922.5 34993.0 34997.8 35009.5 36086.8 36092.3 36199.0 38068.0 38976.0 10616.0 10629.1 10636.6 10658.1 10695.0 8369.2 8372.5 8375.0 8386.0 8408.2 11230.6 11256.2 11303.2 11426.5 11474.8 4587.7 4637.6 4706.5 4735.1 4775.8 796.7 825.2 826.7 827.6 837.7 19366.9 19852.9 20057.6 20099.5 20256.1 885.2 887.0 887.7 898.2 913.1 10145.8 10367.0 10374.3 10452.4 10480.7 182578.0 183539.0 183756.0 184102.0 185423.0 36098.1 36339.6 36400.6 36414.8 36466.3 1044.6 1075.8 1077.4 1082.3 1091.0 18850.0 18954.7 19434.1 19668.5 19936.0 26338.0 26367.0 26485.9 26556.5 26570.7 151945.0 152108.2 152296.2 152401.0 152734.7 26806.9 27032.3 27032.6 27061.4 27125.2 31239.4 31942.4 32178.2 32269.7 32271.2 24641.8 24888.5 25112.7 25171.7 25712.0 24089.6 24141.6 24500.5 24567.3 25306.3 28346.4 28756.9 28891.4 28952.0 29083.4 24451.9 25409.9 25523.7 25570.0 26013.5 20226.0 20642.2 20869.5 20906.4 20959.6 18:30:48 INFO - PID 20557 | 18:30:48 INFO - PID 20557 | [#2] jquery.html Cycles:180 Average:25934.96 Median:389.02 stddev:62218.10 (15993.4%) stddev-sans-first:62363.05 18:30:48 INFO - PID 20557 | Values: 382.2 385.9 392.2 397.6 412.3 13051.9 13819.6 16988.2 17605.5 17640.5 16302.8 16972.7 16973.6 16977.5 17014.7 5348.5 5428.2 5475.6 5475.6 5476.4 5370.4 5442.7 5463.0 5468.2 5469.1 5395.6 5407.5 5415.2 5428.8 5445.6 5203.5 5235.3 5284.6 5330.9 5390.9 4806.6 4817.6 4831.2 4832.7 4836.6 20290.8 20504.5 20625.2 20656.4 20700.3 1572.3 1589.4 1591.0 1593.7 1595.2 13937.2 14004.6 14364.1 14387.6 14472.6 1988.4 2041.8 2046.8 2048.6 2048.7 103662.0 107446.0 107724.0 107837.5 108030.0 9791.3 10101.5 10277.2 10665.3 10910.9 14391.9 14433.6 14445.9 14454.9 14458.0 6889.4 7147.9 7171.6 7232.6 7263.5 6557.4 6580.6 6584.9 6600.5 6644.4 6442.8 6634.8 6673.3 6676.9 6681.5 1954.4 1962.5 1982.2 1985.6 2012.3 757.3 763.9 787.8 791.6 800.1 15922.8 16143.4 16283.3 16440.8 16537.8 786.8 791.6 793.6 806.2 814.5 8707.1 8770.9 8875.4 9053.5 9160.1 359092.0 361227.0 361579.0 375040.0 378268.0 89855.6 91069.0 91468.0 91842.9 91922.0 917.3 939.5 941.5 945.6 946.8 14128.4 14379.7 14530.3 14726.3 15056.8 41972.6 42201.2 42579.8 43732.0 43834.6 55429.0 55450.0 55457.0 55570.7 55808.7 8865.2 9150.5 9246.4 9254.1 9259.4 13579.7 14706.2 14768.4 15184.5 15362.3 11902.9 11932.7 12053.9 12069.8 13278.7 11776.8 12127.3 12246.5 12362.3 12513.8 12742.2 13079.5 13204.9 13390.4 13399.7 8993.9 8994.7 9060.4 9097.6 9119.8 12020.0 12175.7 12246.5 12307.7 12353.4 18:30:48 INFO - PID 20557 | 18:30:48 INFO - PID 20557 | [#3] mootools.html Cycles:180 Average:6292.66 Median:4437.04 stddev:4247.51 (95.7%) stddev-sans-first:4241.15 18:30:48 INFO - PID 20557 | Values: 1049.1 1089.9 1099.8 1103.1 1111.2 8986.7 9273.4 9924.2 10379.3 10381.8 9751.4 10159.1 10179.5 10186.9 10204.2 2079.5 2141.2 2145.8 2147.7 2149.7 1810.8 1879.7 2033.3 2077.5 2080.9 1977.3 2064.4 2065.4 2071.6 2074.5 2072.7 2099.9 2108.1 2108.2 2110.9 2088.3 2092.0 2105.3 2107.7 2114.1 9756.4 9815.4 9945.9 9952.6 9966.5 5267.1 5355.0 5442.5 5444.0 5448.8 3063.1 3287.9 3376.5 3409.9 3417.6 1085.6 1087.7 1095.2 1113.6 1116.4 15483.7 15776.1 15866.3 15900.8 15960.0 4727.6 4734.1 4912.8 4917.7 4938.5 12174.7 12243.1 12260.5 12273.9 12276.3 5476.6 5487.0 5492.0 5494.9 5515.9 4865.1 4900.6 4999.9 5008.2 5010.1 3948.4 4021.0 4081.9 4085.2 4146.4 1208.8 1238.5 1291.1 1303.5 1328.2 608.4 637.4 650.1 652.6 653.5 5866.2 5911.5 6010.3 6090.8 6122.8 752.3 762.4 765.5 767.8 781.1 3374.5 3475.9 3504.2 3534.2 3575.4 13652.9 14193.0 14224.9 14240.4 14251.9 13596.2 13849.4 14034.4 14118.2 14140.1 7146.8 7233.8 7242.8 7247.0 7292.6 5269.9 5331.6 5394.1 5534.1 5648.0 12030.0 12233.4 12242.6 12245.8 12328.3 12738.9 12811.9 12908.2 12984.6 13067.6 7512.7 7645.3 7666.8 7681.9 7682.2 8846.4 9360.3 9490.8 9494.2 9527.2 8078.0 8099.6 8118.2 8203.5 8209.3 7860.2 7910.0 7916.0 8027.0 8055.2 7055.9 7164.4 7168.7 7180.2 7183.9 4899.5 4929.1 4960.1 4972.7 5001.0 4806.4 4887.0 4913.4 4966.4 4991.4 18:30:48 INFO - PID 20557 | 18:30:48 INFO - PID 20557 | [#4] prototype.html Cycles:180 Average:4828.23 Median:5540.60 stddev:1445.86 (26.1%) stddev-sans-first:1410.17 18:30:48 INFO - PID 20557 | Values: 342.5 366.6 376.7 380.3 382.2 5629.0 5645.8 5663.2 5665.2 5677.5 5518.3 5529.9 5539.5 5539.9 5584.9 4026.3 4194.3 4302.6 4310.2 4310.7 4175.8 4185.2 4185.3 4198.3 4200.8 4117.3 4134.5 4138.3 4147.9 4166.1 4136.5 4148.6 4153.7 4154.1 4157.0 3632.6 3643.8 3645.3 3646.3 3646.7 5398.7 5400.8 5411.6 5414.2 5429.3 4887.6 4894.3 4894.8 4908.9 4915.4 5828.9 5830.2 5838.4 5846.6 5859.2 4070.1 4070.3 4070.6 4077.8 4086.3 5910.1 6192.9 6241.1 6243.4 6292.8 4108.9 4141.9 4154.8 4158.9 4170.9 4200.8 4202.5 4205.7 4212.8 4216.1 4665.6 4811.5 4848.3 4874.7 4883.2 5911.9 5918.3 5918.5 5921.3 5941.1 1424.8 1430.5 1434.8 1436.6 1437.9 936.0 970.8 983.3 985.8 986.8 5061.5 5062.1 5064.5 5070.3 5074.0 6056.2 6056.7 6092.8 6106.5 6112.5 5008.7 5019.7 5028.4 5038.7 5056.0 3212.5 3230.8 3237.4 3246.2 3255.0 5616.3 5637.1 5641.4 5647.2 5655.1 6202.9 6241.9 6268.6 6271.2 6277.6 5609.2 5635.6 5639.1 5639.4 5647.1 6062.2 6081.6 6092.4 6105.9 6116.6 6012.1 6012.5 6024.9 6031.4 6040.0 5397.0 5421.2 5541.3 5546.0 5550.3 4084.3 4085.4 4104.2 4104.8 4107.7 6102.8 6112.7 6118.8 6120.8 6135.8 5641.3 5859.9 5865.2 5887.8 5919.4 5816.1 5845.0 5846.1 5846.8 5862.7 5787.5 5795.3 5806.3 5820.5 5822.4 5940.6 5969.6 5976.4 5978.2 5979.9 5754.0 5766.9 5778.2 5780.3 5793.7 18:30:48 INFO - PID 20557 | 18:30:48 INFO - PID 20557 | [#5] yui.html Cycles:180 Average:16681.89 Median:3364.74 stddev:21223.30 (630.8%) stddev-sans-first:21248.57 18:30:48 INFO - PID 20557 | Values: 620.6 627.5 633.8 645.8 648.8 13283.7 13393.7 13445.2 14091.7 16325.0 14719.9 14973.9 14990.4 15011.8 15012.9 632.0 646.6 650.0 652.6 652.9 642.6 655.4 658.7 664.8 670.5 695.7 701.2 702.0 702.9 704.2 703.4 704.7 706.0 707.3 709.8 511.9 512.2 512.8 517.2 522.4 13803.4 13856.3 13875.7 13920.2 13926.5 13958.5 14922.8 14937.3 14942.4 15065.3 12020.5 12227.9 12320.9 12349.8 12405.4 2955.5 2978.2 2980.5 2983.9 2986.8 73391.0 74487.6 74574.0 74662.3 84675.6 11200.8 11496.3 11560.4 11581.9 11651.3 15345.6 15680.6 19469.5 19648.6 20432.6 6013.3 6169.4 6171.8 6185.8 6189.6 2979.4 3017.4 3040.9 3048.5 3057.9 3671.6 3794.6 3823.6 3825.9 3830.1 707.3 722.5 735.4 736.8 736.8 544.0 546.8 559.0 574.7 575.4 9628.9 9896.6 10200.5 10572.6 11172.5 572.4 575.3 575.6 577.4 577.6 4765.9 4914.3 4919.4 4968.5 5079.6 73519.6 74262.6 74448.3 75497.0 86339.6 64511.0 64691.4 65490.0 66370.0 67909.7 57392.7 58038.7 60821.0 60949.0 61415.7 9682.0 9827.9 10458.9 10594.3 10662.9 27129.3 27330.6 27425.5 28558.7 29254.7 49285.3 49420.5 51228.7 51875.5 52790.0 11851.4 12966.5 13536.3 13856.9 14227.3 15117.2 15141.5 15364.8 15487.0 15756.7 13579.9 13882.3 14462.6 14542.6 14558.8 14500.8 14742.9 15007.2 15116.4 15303.1 13999.4 14259.3 14528.7 14547.7 14605.4 11358.3 11487.7 11786.8 11871.0 12044.5 12109.2 12153.0 12563.7 12566.4 12579.9 18:30:48 INFO - PID 20557 | -------- Summary: end -------- 18:30:48 INFO - PID 20557 | 18:30:49 INFO - TEST-INFO | 20557: exit 0 18:30:49 INFO - TEST-OK | dromaeo_css | took 1148220ms 18:30:49 INFO - TEST-START | kraken 18:30:49 INFO - operating with platform_type : linux_ 18:30:49 INFO - Initialising browser for kraken test... 18:30:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59200/getInfo.html -profile /tmp/tmpZuPJIk/profile 18:30:49 INFO - TEST-INFO | started process 20989 (/builds/slave/test/build/application/firefox/firefox http://localhost:59200/getInfo.html) 18:31:24 INFO - TEST-INFO | 20989: killed by SIGTERM 18:31:25 INFO - Browser initialized. 18:31:25 INFO - Running cycle 1/1 for kraken test... 18:31:25 INFO - TEST-INFO | started process 21212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZuPJIk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:36 INFO - PID 21212 | RSS: Main: 188190720 18:31:36 INFO - PID 21212 | 18:31:39 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59200/tests/kraken/driver.html?testName=audio-beat-detection) 18:31:40 INFO - PID 21212 | RSS: Main: 191549440 18:31:40 INFO - PID 21212 | 18:31:43 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59200/tests/kraken/driver.html?testName=audio-dft) 18:31:43 INFO - PID 21212 | RSS: Main: 190246912 18:31:43 INFO - PID 21212 | 18:31:46 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59200/tests/kraken/driver.html?testName=audio-fft) 18:31:47 INFO - PID 21212 | RSS: Main: 186044416 18:31:47 INFO - PID 21212 | 18:31:49 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59200/tests/kraken/driver.html?testName=audio-oscillator) 18:31:50 INFO - PID 21212 | RSS: Main: 186265600 18:31:50 INFO - PID 21212 | 18:31:52 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59200/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:31:53 INFO - PID 21212 | RSS: Main: 186494976 18:31:53 INFO - PID 21212 | 18:31:56 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59200/tests/kraken/driver.html?testName=imaging-darkroom) 18:31:56 INFO - PID 21212 | RSS: Main: 187785216 18:31:56 INFO - PID 21212 | 18:32:00 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59200/tests/kraken/driver.html?testName=imaging-desaturate) 18:32:01 INFO - PID 21212 | RSS: Main: 186736640 18:32:01 INFO - PID 21212 | 18:32:04 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59200/tests/kraken/driver.html?testName=json-parse-financial) 18:32:04 INFO - PID 21212 | RSS: Main: 187183104 18:32:04 INFO - PID 21212 | 18:32:06 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59200/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:32:06 INFO - PID 21212 | RSS: Main: 187330560 18:32:06 INFO - PID 21212 | 18:32:08 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:32:09 INFO - PID 21212 | RSS: Main: 187121664 18:32:09 INFO - PID 21212 | 18:32:11 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:32:12 INFO - PID 21212 | RSS: Main: 187154432 18:32:12 INFO - PID 21212 | 18:32:15 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:32:15 INFO - PID 21212 | RSS: Main: 187203584 18:32:15 INFO - PID 21212 | 18:32:18 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:32:19 INFO - PID 21212 | RSS: Main: 187215872 18:32:19 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | Cycle 1(1): loaded http://localhost:59200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59200/tests/kraken/driver.html?testName=ai-astar) 18:32:21 INFO - PID 21212 | RSS: Main: 188809216 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | __start_tp_report 18:32:21 INFO - PID 21212 | _x_x_mozilla_page_load 18:32:21 INFO - PID 21212 | _x_x_mozilla_page_load_details 18:32:21 INFO - PID 21212 | |i|pagename|runs| 18:32:21 INFO - PID 21212 | |0;ai-astar;103;112;110;111;110;111;111;112;110;110 18:32:21 INFO - PID 21212 | |1;audio-beat-detection;148;129;123;169;123;122;123;125;151;124 18:32:21 INFO - PID 21212 | |2;audio-dft;163;163;167;166;167;167;182;171;163;161 18:32:21 INFO - PID 21212 | |3;audio-fft;74;74;73;114;74;75;74;76;91;79 18:32:21 INFO - PID 21212 | |4;audio-oscillator;83;82;124;82;82;82;99;83;83;109 18:32:21 INFO - PID 21212 | |5;imaging-gaussian-blur;114;115;113;116;117;114;114;114;114;113 18:32:21 INFO - PID 21212 | |6;imaging-darkroom;152;150;150;150;151;150;150;151;154;153 18:32:21 INFO - PID 21212 | |7;imaging-desaturate;95;95;96;94;94;95;94;95;95;94 18:32:21 INFO - PID 21212 | |8;json-parse-financial;55;55;55;57;60;56;56;57;57;56 18:32:21 INFO - PID 21212 | |9;json-stringify-tinderbox;57;58;58;57;58;58;58;57;58;58 18:32:21 INFO - PID 21212 | |10;stanford-crypto-aes;87;86;86;95;86;84;86;85;113;85 18:32:21 INFO - PID 21212 | |11;stanford-crypto-ccm;141;140;134;130;141;133;133;137;132;143 18:32:21 INFO - PID 21212 | |12;stanford-crypto-pbkdf2;200;195;191;189;193;193;188;203;203;191 18:32:21 INFO - PID 21212 | |13;stanford-crypto-sha256-iterative;75;74;72;78;75;71;70;75;71;73 18:32:21 INFO - PID 21212 | __end_tp_report 18:32:21 INFO - PID 21212 | __start_cc_report 18:32:21 INFO - PID 21212 | _x_x_mozilla_cycle_collect,998 18:32:21 INFO - PID 21212 | __end_cc_report 18:32:21 INFO - PID 21212 | __startTimestamp1496194341704__endTimestamp 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | ------- Summary: start ------- 18:32:21 INFO - PID 21212 | Number of tests: 14 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.58 (2.3%) stddev-sans-first:0.83 18:32:21 INFO - PID 21212 | Values: 103.0 112.0 110.0 111.0 110.0 111.0 111.0 112.0 110.0 110.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:127.00 stddev:16.40 (12.9%) stddev-sans-first:16.56 18:32:21 INFO - PID 21212 | Values: 148.0 129.0 123.0 169.0 123.0 122.0 123.0 125.0 151.0 124.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#2] audio-dft Cycles:10 Average:167.00 Median:167.00 stddev:6.02 (3.6%) stddev-sans-first:6.21 18:32:21 INFO - PID 21212 | Values: 163.0 163.0 167.0 166.0 167.0 167.0 182.0 171.0 163.0 161.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#3] audio-fft Cycles:10 Average:80.40 Median:74.50 stddev:12.95 (17.4%) stddev-sans-first:13.53 18:32:21 INFO - PID 21212 | Values: 74.0 74.0 73.0 114.0 74.0 75.0 74.0 76.0 91.0 79.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.50 stddev:14.88 (18.0%) stddev-sans-first:15.51 18:32:21 INFO - PID 21212 | Values: 83.0 82.0 124.0 82.0 82.0 82.0 99.0 83.0 83.0 109.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.26 (1.1%) stddev-sans-first:1.33 18:32:21 INFO - PID 21212 | Values: 114.0 115.0 113.0 116.0 117.0 114.0 114.0 114.0 114.0 113.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.45 (1.0%) stddev-sans-first:1.50 18:32:21 INFO - PID 21212 | Values: 152.0 150.0 150.0 150.0 151.0 150.0 150.0 151.0 154.0 153.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 18:32:21 INFO - PID 21212 | Values: 95.0 95.0 96.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.51 (2.7%) stddev-sans-first:1.51 18:32:21 INFO - PID 21212 | Values: 55.0 55.0 55.0 57.0 60.0 56.0 56.0 57.0 57.0 56.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 18:32:21 INFO - PID 21212 | Values: 57.0 58.0 58.0 57.0 58.0 58.0 58.0 57.0 58.0 58.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:86.00 stddev:8.87 (10.3%) stddev-sans-first:9.37 18:32:21 INFO - PID 21212 | Values: 87.0 86.0 86.0 95.0 86.0 84.0 86.0 85.0 113.0 85.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:138.50 stddev:4.58 (3.3%) stddev-sans-first:4.54 18:32:21 INFO - PID 21212 | Values: 141.0 140.0 134.0 130.0 141.0 133.0 133.0 137.0 132.0 143.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.60 Median:194.00 stddev:5.54 (2.9%) stddev-sans-first:5.52 18:32:21 INFO - PID 21212 | Values: 200.0 195.0 191.0 189.0 193.0 193.0 188.0 203.0 203.0 191.0 18:32:21 INFO - PID 21212 | 18:32:21 INFO - PID 21212 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:74.50 stddev:2.46 (3.3%) stddev-sans-first:2.54 18:32:21 INFO - PID 21212 | Values: 75.0 74.0 72.0 78.0 75.0 71.0 70.0 75.0 71.0 73.0 18:32:21 INFO - PID 21212 | -------- Summary: end -------- 18:32:21 INFO - PID 21212 | 18:32:22 INFO - TEST-INFO | 21212: exit 0 18:32:22 INFO - TEST-OK | kraken | took 93133ms 18:32:22 INFO - SUITE-END | took 1241s 18:32:23 INFO - Completed test suite (00:20:41) 18:32:23 INFO - javascript benchmark 18:32:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6612.25192321907, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2750.3811642380465, 2767.695553489117, 2790.35821760995, 2794.972050279497, 2795.0915952315504, 5144.614153938451, 5296.073187192241, 5302.681839089652, 5356.54469370104, 5358.196270559413, 5197.194434862602, 5265.104932161532, 5267.52592266696, 5310.0972834618115, 5354.598405119622, 4699.812007519695, 4709.646776491777, 4734.337192793012, 4746.406699162605, 4776.785044672998, 4705.106029854333, 4728.290756386536, 4798.592119669832, 4800.255960326155, 4838.564529192372, 4596.770161491912, 4653.255479123324, 4722.76386180693, 4724.881877953045, 4801.399825021872, 4658.208104622222, 4747.952520474785, 4748.738819364934, 4773.665843390964, 4793.952060479421, 4686.437627484724, 4707.411573553306, 4709.293605959099, 4715.198416269208, 4736.550027747358, 5147.0992576298995, 5233.633645644806, 5248.291480650101, 5299.2845965794895, 5355.571554275649, 5665.631733937322, 5672.68800215988, 5729.512991395736, 5753.0, 5786.334571524287, 5775.682337471438, 5791.768329266824, 5792.768289268424, 5807.738651760681, 5812.0, 5346.1713434417725, 5347.117725575236, 5358.758855851457, 5370.677759334452, 5371.409144994048, 5750.712464376765, 5775.537956963432, 5826.970865145732, 5849.590528663038, 5850.502707269845, 5666.2350582670815, 5678.886422271531, 5702.0591602385975, 5705.343885453143, 5729.713514324267, 5675.460831221028, 5737.88524229513, 5745.511631511285, 5761.193432919395, 5764.106563482667, 5493.862653433696, 5551.25058117149, 5709.314882214161, 5723.027085395493, 5727.5131613812455, 5588.9720551397795, 5611.915821262684, 5693.146028095819, 5734.799282025109, 5735.799247026417, 4758.333833263346, 4780.163471392492, 4780.426348838162, 4791.784369703371, 4841.346418233564, 4079.755214687128, 4087.8978025549004, 4095.836166553364, 4112.321466957918, 4141.109661422808, 4712.363830882787, 4784.162771514971, 4788.138135135709, 4814.807407703653, 4858.514148585114, 5728.312602487645, 5729.0260655688635, 5745.712714364265, 5784.074548072288, 5805.535557155417, 4793.400824896888, 4815.277708343707, 4819.975900120477, 4829.541193586604, 4852.17513022787, 4968.701877887338, 5047.116754567863, 5102.3877134743325, 5119.129747942859, 5120.92318615221, 5243.895122097613, 5293.841184764463, 5322.680639161663, 5337.599680024091, 5339.866503337447, 5567.749451274622, 5660.915086273627, 5710.314762228559, 5732.770689172553, 5737.110747834093, 5193.896122077613, 5212.452692467236, 5232.424433312256, 5238.764255608583, 5337.306150200449, 5662.716864156858, 5664.0371136906, 5667.4332566743, 5683.8010669626365, 5713.685747283939, 5618.606697531133, 5619.831405057855, 5711.3431955324, 5747.051736463437, 5773.364929857628, 5563.693996830213, 5578.219049333178, 5599.0, 5599.80400685974, 5614.691191984317, 5528.19841123043, 5539.362973257966, 5561.555075593862, 5566.554675625859, 5572.60991730575, 5353.437889021597, 5390.110631745718, 5464.9180262296895, 5468.644538105011, 5518.255035570147, 5509.146082357241, 5537.916931246115, 5546.084895992116, 5617.241672374177, 5631.0, 5387.838364849061, 5393.27190829233, 5404.108322126962, 5407.7025763581805, 5444.128939369682], "value": 5174.370876165641, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.8867815115128, 652.451940370089, 665.2216906219722, 1078.3314345106035, 1092.421016861063, 31100.22249443762, 31927.521087183683, 31969.040928772145, 31992.0, 32025.199370015704, 30298.545521817134, 30908.0, 30963.535546966756, 30974.0, 30986.690133098662, 6615.503837212204, 6765.0, 6771.8984215236815, 6775.932240677604, 6782.864342713143, 6580.868382632344, 6604.801855944305, 6709.429698475636, 6712.899306510406, 6718.227403848547, 6660.433863121616, 6711.966440167792, 6734.966325168391, 6735.9663201683925, 6746.527743057988, 6707.429868461187, 6709.194896612414, 6721.428678562328, 6726.932730672728, 6729.091572637681, 6513.316101809289, 6571.342865713438, 6578.93421065788, 6589.439897608709, 6606.768763093269, 28771.56842647362, 28913.277168070756, 28928.421431571252, 28950.855245723636, 28957.131286061453, 2733.2073698627373, 2743.5198840203084, 2753.752162305402, 2759.6412466379443, 2761.0750398616487, 22643.660345094835, 22805.0, 22808.65787013196, 22867.085316587316, 22880.0, 2924.1227631710613, 2943.499605067144, 2947.911562653124, 2950.601668774731, 2957.6155099837097, 145308.0, 146035.0, 146035.26982365127, 151777.0, 155670.22164889215, 34722.30555388878, 34922.47616285758, 34993.0, 34997.82501087478, 35009.474857877154, 36086.819565902006, 36092.27815443729, 36199.0, 38068.0, 38976.0, 10616.044555989998, 10629.096526795154, 10636.627718029831, 10658.081545321762, 10695.0, 8369.246767790928, 8372.497650141011, 8375.0, 8386.0, 8408.159184081544, 11230.606928757617, 11256.212065155525, 11303.1522635801, 11426.485808138488, 11474.827877581843, 4587.7017993830295, 4637.582617564435, 4706.505816889246, 4735.147673418817, 4775.808967641256, 796.6972550430916, 825.2284114353099, 826.68999125328, 827.5613924619961, 837.6816809612309, 19366.903165484084, 19852.90073549623, 20057.598848022957, 20099.49751256201, 20256.088476018616, 885.2210055151426, 886.9822603547893, 887.7248053103558, 898.1557336104172, 913.0960349254191, 10145.847812282822, 10367.0, 10374.27380083387, 10452.425116618659, 10480.68557943263, 182578.0, 183539.0, 183756.0, 184102.0, 185423.0, 36098.097547560996, 36339.636603633626, 36400.63599364025, 36414.8179259102, 36466.27067458689, 1044.6448207609449, 1075.8117329467468, 1077.3535878472853, 1082.3019152646498, 1090.9945450272699, 18850.0, 18954.715679264547, 19434.12546435442, 19668.50828729293, 19936.0, 26338.0, 26367.0, 26485.867570662023, 26556.46887062209, 26570.734292656827, 151945.0, 152108.239458802, 152296.2385188067, 152401.0, 152734.70897936763, 26806.865965670047, 27032.32419189536, 27032.59451108274, 27061.39956207489, 27125.18624441191, 31239.375212496077, 31942.423094559523, 32178.19554511156, 32269.67730322667, 32271.193220169684, 24641.753582463945, 24888.502229955662, 25112.74887251104, 25171.74828251694, 25712.0, 24089.638655419833, 24141.63787543153, 24500.50998980046, 24567.262982110566, 25306.28158411702, 28346.433071338044, 28756.856215718788, 28891.42217155603, 28952.0, 29083.418331632827, 24451.877740611893, 25409.87295063513, 25523.744762552138, 25570.0, 26013.479730405663, 20226.0, 20642.17431302731, 20869.478263043544, 20906.37280881576, 20959.580808384053], "value": 13382.935231172263, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.2069206396728, 385.87073330434305, 392.17447273489296, 397.5527531527032, 412.28674393299593, 13051.869481305208, 13819.585412437644, 16988.150592470374, 17605.471835844928, 17640.470785876412, 16302.83697163028, 16972.66054678906, 16973.57566060849, 16977.49067527973, 17014.659706805858, 5348.491893270153, 5428.212909128174, 5475.561955043587, 5475.561955043587, 5476.3702174249875, 5370.43610420906, 5442.673439593637, 5462.9726851365685, 5468.179773034057, 5469.07025805614, 5395.59533035022, 5407.5133238008575, 5415.241866138724, 5428.809991650293, 5445.591580631449, 5203.531682148606, 5235.319408476893, 5284.603654725911, 5330.866728331823, 5390.865228369283, 4806.558032590244, 4817.61459083276, 4831.22700367943, 4832.710037397767, 4836.564709176156, 20290.79709202904, 20504.487387815276, 20625.174993000262, 20656.380308590768, 20700.275490357766, 1572.2846105022188, 1589.36425429829, 1591.0, 1593.6812637472551, 1595.1784830812142, 13937.163770173822, 14004.579862604036, 14364.138151710826, 14387.640308992255, 14472.638184045378, 1988.443235893952, 2041.7754047054812, 2046.8464865135174, 2048.5902819436023, 2048.72342233798, 103662.0, 107446.0, 107724.0, 107837.46081269544, 108030.0, 9791.265655075898, 10101.545430455648, 10277.248804186418, 10665.306755060896, 10910.945445272722, 14391.920605954387, 14433.639159021108, 14445.92777036108, 14454.85545144556, 14458.0, 6889.379955804002, 7147.928520714726, 7171.605561694157, 7232.566046037149, 7263.455240856957, 6557.409833115043, 6580.5722628029025, 6584.934150658432, 6600.471962243009, 6644.4020038196795, 6442.843006926572, 6634.767783127568, 6673.299303573152, 6676.9332306676315, 6681.465482761368, 1954.3843689237845, 1962.479942815155, 1982.1575830272077, 1985.5532505186507, 2012.2655230840637, 757.2541047068632, 763.9121501027341, 787.7597332813547, 791.5883740454931, 800.1118758178417, 15922.76115858263, 16143.434979775651, 16283.267252973645, 16440.83559164393, 16537.751933721003, 786.7679034684782, 791.639803889229, 793.5754371411267, 806.1776987472745, 814.4746638418187, 8707.129287071242, 8770.868436973451, 8875.423097498642, 9053.456792592466, 9160.129787670161, 359092.0, 361227.0, 361579.02892820165, 375040.0, 378268.0, 89855.55072224728, 91069.0, 91468.0, 91842.89728129901, 91922.0, 917.3165991336364, 939.4598106089027, 941.5339406993445, 945.6264775413673, 946.8059047895165, 14128.364223609757, 14379.712405752036, 14530.346134424188, 14726.263686815402, 15056.774148387563, 41972.580274196866, 42201.1559768809, 42579.7871010643, 43732.0, 43834.56165438305, 55429.0, 55450.0, 55457.0, 55570.722146390624, 55808.72095639496, 8865.20213180791, 9150.450972941378, 9246.445213287225, 9254.074592540692, 9259.398139120936, 13579.728405431639, 14706.191159485903, 14768.409263629765, 15184.544463666107, 15362.30869610848, 11902.940485297519, 11932.701682458008, 12053.939730301292, 12069.818952715541, 13278.668033299246, 11776.82334764962, 12127.332996685267, 12246.510139594673, 12362.320072396105, 12513.812292815433, 12742.235465872078, 13079.542216022393, 13204.867951320748, 13390.397432115384, 13399.665008374868, 8993.910060899307, 8994.730158095268, 9060.411073280216, 9097.636094556408, 9119.772005699911, 12020.0, 12175.703568947536, 12246.510139594673, 12307.692307692021, 12353.444095015926], "value": 8836.609106612383, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1049.1187402581832, 1089.907357874581, 1099.8295264234046, 1103.0899507905979, 1111.1832802889874, 8986.730398088068, 9273.397229180098, 9924.20606351492, 10379.273450858444, 10381.844272335911, 9751.366161199518, 10159.13647339975, 10179.491025448735, 10186.949065254663, 10204.234682398812, 2079.4905248214172, 2141.1649456711893, 2145.7639659637425, 2147.667111597697, 2149.7312835895514, 1810.8008119106887, 1879.736836842843, 2033.3290014295246, 2077.511784730587, 2080.9479763005893, 1977.2782934228974, 2064.411642681836, 2065.380385884229, 2071.6063947849934, 2074.5332300232476, 2072.6580114281123, 2099.9475013124643, 2108.146200788683, 2108.1778106538463, 2110.905009274579, 2088.3004193595166, 2091.989540052305, 2105.2947262667026, 2107.6522373808302, 2114.1332053858, 9756.414615123116, 9815.411075335503, 9945.850812237823, 9952.552135153863, 9966.451845148515, 5267.078261304257, 5355.036093503168, 5442.455754424565, 5444.0, 5448.782048718046, 3063.1423201503394, 3287.9342413151844, 3376.5441665375106, 3409.9488507672404, 3417.6069751978594, 1085.592902661502, 1087.6519513755602, 1095.1950316517352, 1113.604670342025, 1116.4417791104447, 15483.690326193526, 15776.053436793714, 15866.286017129258, 15900.76148857768, 15960.0, 4727.64542659302, 4734.124187025412, 4912.754362281943, 4917.65576409655, 4938.530839570235, 12174.695632609255, 12243.142979991493, 12260.509579616715, 12273.877261227452, 12276.32480213579, 5476.616636835463, 5487.0, 5492.038893193675, 5494.890102198014, 5515.889682206413, 4865.099956508057, 4900.558949694545, 4999.925001124986, 5008.198688209869, 5010.148274793294, 3948.4274780156716, 4020.979895100506, 4081.8775436736946, 4085.162541678949, 4146.4402305688345, 1208.8186771984272, 1238.541495132162, 1291.063978615515, 1303.4590644882458, 1328.1566205459603, 608.4341562347059, 637.3594537489793, 650.0509256485584, 652.6019128331714, 653.5261935097112, 5866.178734977107, 5911.527077833763, 6010.308814486302, 6090.786822461193, 6122.7550897964475, 752.259024860512, 762.4357975098387, 765.548326487364, 767.8195624028349, 781.0588241169377, 3374.4769560718128, 3475.878344257939, 3504.229069604683, 3534.2401383702113, 3575.3743094958277, 13652.931735341259, 14193.0, 14224.85775142256, 14240.359183836545, 14251.92874035644, 13596.184228946295, 13849.446022159202, 14034.36845341962, 14118.152910825384, 14140.080894741808, 7146.821329466805, 7233.819154521179, 7242.818929526804, 7247.0, 7292.562446253136, 5269.947300526946, 5331.626786125089, 5394.109971854757, 5534.142207957773, 5648.0, 12030.0, 12233.388330583257, 12242.632721018384, 12245.755084898074, 12328.260304381765, 12738.87261127377, 12811.935940320238, 12908.225506469642, 12984.610461686165, 13067.607971760863, 7512.661930213263, 7645.273698998586, 7666.846663066596, 7681.923180768121, 7682.193369696101, 8846.424982376126, 9360.344775865897, 9490.810183796424, 9494.192993595621, 9527.237820974167, 8078.0, 8099.635516401894, 8118.228768267005, 8203.466774659628, 8209.302209312274, 7860.174681658572, 7909.960450197712, 7916.0, 8027.0, 8055.234752698484, 7055.929440705528, 7164.355208031302, 7168.67740951648, 7180.174279957663, 7183.928160718535, 4899.534544218293, 4929.137400954747, 4960.107180707508, 4972.676776009548, 5001.049800537886, 4806.399200099988, 4886.975565122151, 4913.41039075299, 4966.379202599675, 4991.401031876198], "value": 4649.78736152072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.5067902220802, 366.58026559589285, 376.65159727252285, 380.2679841305486, 382.19166462930895, 5629.014922388581, 5645.774169033239, 5663.235463212465, 5665.150227465877, 5677.536702611404, 5518.323613047679, 5529.861753456165, 5539.473749993744, 5539.947409992099, 5584.86037849054, 4026.3356546169994, 4194.328907374821, 4302.569743025696, 4310.245707001278, 4310.719803212797, 4175.791210439465, 4185.162967406515, 4185.28850095483, 4198.307279298912, 4200.789960501963, 4117.300058989964, 4134.4831896013, 4138.33786594145, 4147.8963025924295, 4166.062635906927, 4136.544980052192, 4148.6266236038755, 4153.6677065834665, 4154.127633197032, 4157.0, 3632.637760839685, 3643.7995910224927, 3645.2891686121216, 3646.2889736501393, 3646.690031347339, 5398.676079435247, 5400.83797486076, 5411.594130440233, 5414.214938833847, 5429.267048948421, 4887.584555312803, 4894.290327902434, 4894.755262236874, 4908.901821963541, 4915.3855768029, 5828.854278643025, 5830.2420685310635, 5838.41615838417, 5846.561507886926, 5859.150423188614, 4070.1045769930865, 4070.348744200943, 4070.5522392536795, 4077.7553346799286, 4086.3053280942313, 5910.1430292607765, 6192.907106393408, 6241.096465577997, 6243.406876346739, 6292.811215663537, 4108.938365924513, 4141.937870931938, 4154.792260386968, 4158.854440094582, 4170.874873753793, 4200.789960501963, 4202.537720850704, 4205.726627769185, 4212.768297743653, 4216.093539888939, 4665.5567721066445, 4811.542903424169, 4848.345473361122, 4874.707517548958, 4883.218685010382, 5911.881762364728, 5918.319393269829, 5918.526517878559, 5921.319048309413, 5941.108833674897, 1424.750668632985, 1430.5207755402057, 1434.7517659636183, 1436.5762100180473, 1437.9431118128168, 935.9953200233955, 970.8495183246467, 983.2625530851861, 985.7929834734642, 986.7631768375538, 5061.493850614909, 5062.063518249136, 5064.4935506449065, 5070.29015937769, 5073.974630126826, 6056.212692349966, 6056.66688332146, 6092.786752463642, 6106.4809491192855, 6112.541559383064, 5008.69947803133, 5019.67372120811, 5028.396592408934, 5038.697678139323, 5055.974720126449, 3212.5020621803656, 3230.7576931730214, 3237.4496335623003, 3246.188452886778, 3254.9674503254664, 5616.326040875121, 5637.098064309691, 5641.379448260688, 5647.181158732043, 5655.123455864347, 6202.875942481125, 6241.937580624226, 6268.623882567061, 6271.150010746841, 6277.623342599459, 5609.242752228397, 5635.5773317001385, 5639.125935480007, 5639.351474580394, 5647.124695672095, 6062.242219722535, 6081.6351018939, 6092.390760923872, 6105.877882442415, 6116.633002019893, 6012.108134028589, 6012.48269762194, 6024.8853962017165, 6031.396860314109, 6040.003399439043, 5397.0, 5421.186821976735, 5541.259649736492, 5545.972270138624, 5550.27846379968, 4084.3465045593753, 4085.3871919212356, 4104.199681062164, 4104.815283312318, 4107.712460127762, 6102.755889764538, 6112.72492737819, 6118.768452972644, 6120.816375508742, 6135.785247516315, 5641.26663533738, 5859.882802344015, 5865.237519122486, 5887.8233652990475, 5919.4080591940465, 5816.069428891357, 5845.041910959876, 5846.123081537803, 5846.824595262149, 5862.677552734641, 5787.536997040311, 5795.33353664334, 5806.274215723035, 5820.505257053029, 5822.359540450631, 5940.61386009908, 5969.552283578836, 5976.372480889618, 5978.192943952511, 5979.850503737442, 5753.97123014399, 5766.913496297475, 5778.191053252464, 5780.335261444988, 5793.681347525927], "value": 4375.835900161949, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.5966122020689, 627.5450298533564, 633.8035209085184, 645.7804346522181, 648.8053583924822, 13283.667908302285, 13393.732125357486, 13445.193288402703, 14091.718165636681, 16325.0, 14719.926400367984, 14973.850261497382, 14990.400383984628, 15011.84988150121, 15012.924935375335, 632.014058069412, 646.6217262901208, 650.0152269311997, 652.6084349390352, 652.8531080506872, 642.5823214910322, 655.3675702946656, 658.7397977798767, 664.7640087768845, 670.5071772247394, 695.6556504530265, 701.2461603775961, 701.9821259174192, 702.9051078104467, 704.2394214248625, 703.4372501998432, 704.6617623540678, 705.9541129826596, 707.2997732245092, 709.8118998465385, 511.9334486516729, 512.1805111821094, 512.787193314774, 517.1983425690203, 522.4096770649143, 13803.447862085504, 13856.30718464083, 13875.722485550334, 13920.234387108705, 13926.51257205993, 13958.51145209923, 14922.776158357634, 14937.327820248114, 14942.402303907831, 15065.322060507195, 12020.51917923282, 12227.877721222763, 12320.938395308056, 12349.753004939941, 12405.44175512104, 2955.4975654138634, 2978.195887110468, 2980.508216144334, 2983.925401864949, 2986.835724035177, 73391.0, 74487.62756186184, 74574.0, 74662.25337746607, 84675.5766221165, 11200.831987520194, 11496.252743571808, 11560.364179970182, 11581.942090289494, 11651.30092194471, 15345.6163595911, 15680.607984800472, 19469.51326216856, 19648.60702785936, 20432.59134817325, 6013.338532761392, 6169.352218017133, 6171.814845554641, 6185.84535386619, 6189.597676151036, 2979.4190132924305, 3017.4116047370553, 3040.9239769005508, 3048.4969979953057, 3057.8929737459084, 3671.57776855665, 3794.582595914447, 3823.5602905665646, 3825.8713679464627, 3830.1190726133145, 707.3334697337274, 722.5231347310855, 735.3933005270566, 736.7642354446525, 736.8378956629533, 543.9584577642381, 546.7812874850092, 559.0245022435794, 574.74136638512, 575.4015823543551, 9628.90371096294, 9896.60413583463, 10200.540975656113, 10572.629957951589, 11172.497237624326, 572.3503823160743, 575.3383608849773, 575.5855783835632, 577.4023885278716, 577.5610535992676, 4765.880852978634, 4914.311996320518, 4919.434265059493, 4968.478309777493, 5079.568236699848, 73519.63240183872, 74262.62868685622, 74448.25551744521, 75497.0, 86339.56830215809, 64511.0, 64691.35308646948, 65490.0, 66370.00444993233, 67909.66045169742, 57392.71303643539, 58038.7098064507, 60821.0, 60949.0, 61415.692921536, 9681.951590242004, 9827.85258221113, 10458.895411045793, 10594.258401911793, 10662.946685266834, 27129.321766955985, 27330.590041149797, 27425.451490970467, 28558.714412855606, 29254.70745292605, 49285.26072108993, 49420.50579494303, 51228.74385628048, 51875.481245188574, 52790.0, 11851.407429628656, 12966.481340746264, 13536.255505947267, 13856.861431385558, 14227.288635568388, 15117.244137793286, 15141.545753627408, 15364.846351536342, 15487.0, 15756.684866302381, 13579.86420135786, 13882.305884705522, 14462.566123016326, 14542.5637230879, 14558.781618275523, 14500.782488262474, 14742.852571474148, 15007.249637518298, 15116.395344186549, 15303.081815091131, 13999.370028348952, 14259.287035648384, 14528.709425811214, 14547.709045818812, 14605.415783368546, 11358.26171298863, 11487.655370338904, 11786.823197652213, 11871.0, 12044.457999389873, 12109.212901161396, 12153.0, 12563.738527065216, 12566.371681416076, 12579.93710031444], "value": 6712.416033702516, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 110.0, 111.0, 110.0, 111.0, 111.0, 112.0, 110.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 129.0, 123.0, 169.0, 123.0, 122.0, 123.0, 125.0, 151.0, 124.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 167.0, 166.0, 167.0, 167.0, 182.0, 171.0, 163.0, 161.0], "value": 167.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 114.0, 74.0, 75.0, 74.0, 76.0, 91.0, 79.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 124.0, 82.0, 82.0, 82.0, 99.0, 83.0, 83.0, 109.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 116.0, 117.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 150.0, 150.0, 151.0, 150.0, 150.0, 151.0, 154.0, 153.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 57.0, 60.0, 56.0, 56.0, 57.0, 57.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 57.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 95.0, 86.0, 84.0, 86.0, 85.0, 113.0, 85.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 134.0, 130.0, 141.0, 133.0, 133.0, 137.0, 132.0, 143.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 195.0, 191.0, 189.0, 193.0, 193.0, 188.0, 203.0, 203.0, 191.0], "value": 194.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 72.0, 78.0, 75.0, 71.0, 70.0, 75.0, 71.0, 73.0], "value": 73.4, "unit": "score"}]}]} 18:32:23 INFO - Return code: 0 18:32:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:32:23 INFO - # TBPL SUCCESS # 18:32:23 INFO - Running post-action listener: _resource_record_post_action 18:32:23 INFO - [mozharness: 2017-05-31 01:32:23.513845Z] Finished run-tests step (success) 18:32:23 INFO - Running post-run listener: _resource_record_post_run 18:32:23 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 8192; Write bytes: 410210304; Read time: 32; Write time: 368000 18:32:23 INFO - TinderboxPrint: CPU usage
12.7% 18:32:23 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 32 18:32:23 INFO - TinderboxPrint: I/O write bytes / time
410,210,304 / 368,000 18:32:23 INFO - TinderboxPrint: CPU idle
8,765.3 (87.3%) 18:32:23 INFO - TinderboxPrint: CPU user
1,222.2 (12.2%) 18:32:23 INFO - TinderboxPrint: Swap in / out
0 / 0 18:32:23 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 99803136; Read time: 0; Write time: 120300 18:32:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:32:23 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310407168; Read time: 20; Write time: 247700 18:32:24 INFO - Running post-run listener: _upload_blobber_files 18:32:24 INFO - Blob upload gear active. 18:32:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:32:24 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 18:32:24 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'] 18:32:24 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 18:32:24 INFO - (blobuploader) - INFO - Open directory for files ... 18:32:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:32:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:32:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:25 INFO - (blobuploader) - INFO - Done attempting. 18:32:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:32:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:32:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:26 INFO - (blobuploader) - INFO - Done attempting. 18:32:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:32:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:32:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:27 INFO - (blobuploader) - INFO - Done attempting. 18:32:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:32:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:32:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:34 INFO - (blobuploader) - INFO - Done attempting. 18:32:34 INFO - (blobuploader) - INFO - Iteration through files over. 18:32:34 INFO - Return code: 0 18:32:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:32:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:32:34 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d2f67584d18b7b61a73ab2d1b8fe046b14735a184ec3b939aa036fb9b8578b579e6cc3e8dedb408a3038123de95d399ba951495e0d7c965a2e1e867451b7f94", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6655449dca8826826f11d0b6b8cfab2581ed9f87744f81ebfcc46f54cfdb85ae41e549cb410425fca7d92699255568f6573dccd5060dba48ba4a9645672463a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c13ef1df86a243ef4ec7e1d513fc2b95f63901b9f9457e4887f2dce9309682f447eb0b49d0e34cc731490230d0039d7d2a0987430423aa42df0fa75843d288a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09b0725fa57afc3c6cbf02c7463363dcd4873a50cdc31cd7b6e4277a6718043f20d8196fb14bd42fa00beeb72c534aa985c1926b782035dca1496da38ce2c6ae"} 18:32:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:32:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:32:34 INFO - Contents: 18:32:34 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d2f67584d18b7b61a73ab2d1b8fe046b14735a184ec3b939aa036fb9b8578b579e6cc3e8dedb408a3038123de95d399ba951495e0d7c965a2e1e867451b7f94", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6655449dca8826826f11d0b6b8cfab2581ed9f87744f81ebfcc46f54cfdb85ae41e549cb410425fca7d92699255568f6573dccd5060dba48ba4a9645672463a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c13ef1df86a243ef4ec7e1d513fc2b95f63901b9f9457e4887f2dce9309682f447eb0b49d0e34cc731490230d0039d7d2a0987430423aa42df0fa75843d288a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09b0725fa57afc3c6cbf02c7463363dcd4873a50cdc31cd7b6e4277a6718043f20d8196fb14bd42fa00beeb72c534aa985c1926b782035dca1496da38ce2c6ae"} 18:32:34 INFO - Running post-run listener: copy_logs_to_upload_dir 18:32:34 INFO - Copying logs to upload dir... 18:32:34 INFO - mkdir: /builds/slave/test/build/upload/logs 18:32:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1324.596384 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2017-05-30 18:32:33.935109) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 18:32:33.938589) ========= 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=920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009 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/1d2f67584d18b7b61a73ab2d1b8fe046b14735a184ec3b939aa036fb9b8578b579e6cc3e8dedb408a3038123de95d399ba951495e0d7c965a2e1e867451b7f94", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6655449dca8826826f11d0b6b8cfab2581ed9f87744f81ebfcc46f54cfdb85ae41e549cb410425fca7d92699255568f6573dccd5060dba48ba4a9645672463a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c13ef1df86a243ef4ec7e1d513fc2b95f63901b9f9457e4887f2dce9309682f447eb0b49d0e34cc731490230d0039d7d2a0987430423aa42df0fa75843d288a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09b0725fa57afc3c6cbf02c7463363dcd4873a50cdc31cd7b6e4277a6718043f20d8196fb14bd42fa00beeb72c534aa985c1926b782035dca1496da38ce2c6ae"} build_url:https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/P5nXGJZ6QkihNdzCz1Oq7w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d2f67584d18b7b61a73ab2d1b8fe046b14735a184ec3b939aa036fb9b8578b579e6cc3e8dedb408a3038123de95d399ba951495e0d7c965a2e1e867451b7f94", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6655449dca8826826f11d0b6b8cfab2581ed9f87744f81ebfcc46f54cfdb85ae41e549cb410425fca7d92699255568f6573dccd5060dba48ba4a9645672463a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c13ef1df86a243ef4ec7e1d513fc2b95f63901b9f9457e4887f2dce9309682f447eb0b49d0e34cc731490230d0039d7d2a0987430423aa42df0fa75843d288a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09b0725fa57afc3c6cbf02c7463363dcd4873a50cdc31cd7b6e4277a6718043f20d8196fb14bd42fa00beeb72c534aa985c1926b782035dca1496da38ce2c6ae"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 18:32:33.962868) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:32:33.963197) ========= 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=920470bf432669ad7e3a5387000001ca-1496189405.658439-878680009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 18:32:34.049160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 18:32:34.049476) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 18:32:34.049801) ========= ========= Total master_lag: 0.62 =========