builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1496797156.71 results: success (0) revision: 5801aa478de12a62b2b2982659e787fcc4268d67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:16.712378) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:16.713190) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:16.713471) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:16.778946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:16.779310) ========= 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-1496789410.485969-1762224138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-06 17:59:17-- 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% 57.9K=0.2s 2017-06-06 17:59:17 (57.9 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.328934 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:17.122638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:17.126006) ========= 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-1496789410.485969-1762224138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018717 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:17.178674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-06 17:59:17.179000) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5801aa478de12a62b2b2982659e787fcc4268d67 --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 5801aa478de12a62b2b2982659e787fcc4268d67 --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-1496789410.485969-1762224138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-06 17:59:17,688 truncating revision to first 12 chars 2017-06-06 17:59:17,688 Setting DEBUG logging. 2017-06-06 17:59:17,688 attempt 1/10 2017-06-06 17:59:17,689 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5801aa478de1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-06 17:59:18,395 unpacking tar archive at: mozilla-central-5801aa478de1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.049530 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-06 17:59:18.240448) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:18.240737) ========= script_repo_revision: 5801aa478de12a62b2b2982659e787fcc4268d67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:18.241123) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:18.241391) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 17:59:18.248721) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-06 17:59:18.249024) ========= /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-1496789410.485969-1762224138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:59:18 INFO - MultiFileLogger online at 20170606 17:59:18 in /builds/slave/test 17:59:18 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 17:59:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:59:18 INFO - {'append_to_log': False, 17:59:18 INFO - 'base_work_dir': '/builds/slave/test', 17:59:18 INFO - 'blob_upload_branch': 'Firefox', 17:59:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:59:18 INFO - 'branch': 'Firefox', 17:59:18 INFO - 'buildbot_json_path': 'buildprops.json', 17:59:18 INFO - 'config_files': ('talos/linux_config.py',), 17:59:18 INFO - 'default_actions': ('clobber', 17:59:18 INFO - 'read-buildbot-config', 17:59:18 INFO - 'download-and-extract', 17:59:18 INFO - 'populate-webroot', 17:59:18 INFO - 'create-virtualenv', 17:59:18 INFO - 'install', 17:59:18 INFO - 'setup-mitmproxy', 17:59:18 INFO - 'run-tests'), 17:59:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:59:18 INFO - 'download_minidump_stackwalk': True, 17:59:18 INFO - 'download_symbols': 'ondemand', 17:59:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:59:18 INFO - 'tooltool.py': '/tools/tooltool.py', 17:59:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:59:18 INFO - '/tools/misc-python/virtualenv.py')}, 17:59:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:59:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:59:18 INFO - 'gecko_profile': False, 17:59:18 INFO - 'gecko_profile_interval': 0, 17:59:18 INFO - 'installer_path': 'installer.exe', 17:59:18 INFO - 'log_level': 'info', 17:59:18 INFO - 'log_name': 'talos', 17:59:18 INFO - 'log_to_console': True, 17:59:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:59:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:59:18 INFO - 'opt_config_files': (), 17:59:18 INFO - 'pip_index': False, 17:59:18 INFO - 'suite': 'dromaeojs-e10s', 17:59:18 INFO - 'system_bits': '32', 17:59:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:59:18 INFO - 'title': 'talos-linux64-ix-053', 17:59:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:59:18 INFO - 'use_talos_json': True, 17:59:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:59:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:59:18 INFO - 'work_dir': 'build'} 17:59:18 INFO - [mozharness: 2017-06-07 00:59:18.864576Z] Running clobber step. 17:59:18 INFO - Running pre-action listener: _resource_record_pre_action 17:59:18 INFO - Running main action method: clobber 17:59:18 INFO - rmtree: /builds/slave/test/build 17:59:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:59:20 INFO - Running post-action listener: _resource_record_post_action 17:59:20 INFO - [mozharness: 2017-06-07 00:59:20.394196Z] Finished clobber step (success) 17:59:20 INFO - [mozharness: 2017-06-07 00:59:20.394295Z] Running read-buildbot-config step. 17:59:20 INFO - Running pre-action listener: _resource_record_pre_action 17:59:20 INFO - Running main action method: read_buildbot_config 17:59:20 INFO - Using buildbot properties: 17:59:20 INFO - { 17:59:20 INFO - "project": "", 17:59:20 INFO - "product": "firefox", 17:59:20 INFO - "who": "kwierso@gmail.com", 17:59:20 INFO - "installer_path": "public/build/target.tar.bz2", 17:59:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 17:59:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:59:20 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 17:59:20 INFO - "stage_platform": "linux64-stylosequential", 17:59:20 INFO - "basedir": "/builds/slave/test", 17:59:20 INFO - "buildnumber": 50, 17:59:20 INFO - "platform": "ubuntu64_hw_styloseq", 17:59:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:59:20 INFO - "slavebuilddir": "test", 17:59:20 INFO - "taskId": "PeNkUHGtRuyp5Lf0aZHkvQ", 17:59:20 INFO - "branch": "mozilla-central", 17:59:20 INFO - "script_repo_revision": "production", 17:59:20 INFO - "revision": "5801aa478de12a62b2b2982659e787fcc4268d67", 17:59:20 INFO - "slavename": "talos-linux64-ix-053", 17:59:20 INFO - "repo_path": "mozilla-central" 17:59:20 INFO - } 17:59:20 INFO - Finding installer, test and symbols from parent task. 17:59:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PeNkUHGtRuyp5Lf0aZHkvQ'}, attempt #1 17:59:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PeNkUHGtRuyp5Lf0aZHkvQ'}, attempt #1 17:59:21 INFO - Task dependencies: NRSVz81RQ9iSzTtcJ00cnw 17:59:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw'}, attempt #1 17:59:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2 17:59:21 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/test_packages.json 17:59:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.crashreporter-symbols.zip 17:59:21 INFO - Running post-action listener: _resource_record_post_action 17:59:21 INFO - [mozharness: 2017-06-07 00:59:21.757255Z] Finished read-buildbot-config step (success) 17:59:21 INFO - [mozharness: 2017-06-07 00:59:21.757474Z] Running download-and-extract step. 17:59:21 INFO - Running pre-action listener: _resource_record_pre_action 17:59:21 INFO - Running main action method: download_and_extract 17:59:21 INFO - mkdir: /builds/slave/test/build/tests 17:59:21 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')]} 17:59:21 INFO - trying https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.test_packages.json 17:59:21 INFO - Downloading https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:59:22 INFO - Downloaded 989 bytes. 17:59:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:59:22 INFO - Using the following test package requirements: 17:59:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:59:22 INFO - u'common': [u'target.common.tests.zip'], 17:59:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:59:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:59:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:59:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:59:22 INFO - u'mozbase': [u'target.common.tests.zip'], 17:59:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:59:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:59:22 INFO - u'web-platform': [u'target.common.tests.zip', 17:59:22 INFO - u'target.web-platform.tests.tar.gz'], 17:59:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:59:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:59:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.common.tests.zip 17:59:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:59:22 INFO - Fetch https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.common.tests.zip into memory 17:59:25 INFO - Content-Length response header: 65110310 17:59:25 INFO - Bytes received: 65110310 17:59:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:59:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.common.tests.zip 17:59:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:59:36 INFO - Fetch https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.common.tests.zip into memory 17:59:38 INFO - Content-Length response header: 65110310 17:59:38 INFO - Bytes received: 65110310 17:59:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.talos.tests.zip 17:59:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:59:50 INFO - Fetch https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.talos.tests.zip into memory 17:59:51 INFO - Content-Length response header: 14447563 17:59:51 INFO - Bytes received: 14447563 17:59:51 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')]} 17:59:51 INFO - trying https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2 17:59:51 INFO - Downloading https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:59:54 INFO - Downloaded 60599533 bytes. 17:59:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2 17:59:54 INFO - mkdir: /builds/slave/test/properties 17:59:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:59:54 INFO - Writing to file /builds/slave/test/properties/build_url 17:59:54 INFO - Contents: 17:59:54 INFO - build_url:https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2 17:59:54 INFO - Running post-action listener: _resource_record_post_action 17:59:54 INFO - Running post-action listener: set_extra_try_arguments 17:59:54 INFO - [mozharness: 2017-06-07 00:59:54.647597Z] Finished download-and-extract step (success) 17:59:54 INFO - [mozharness: 2017-06-07 00:59:54.647827Z] Running populate-webroot step. 17:59:54 INFO - Running pre-action listener: _resource_record_pre_action 17:59:54 INFO - Running main action method: populate_webroot 17:59:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:59:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:59:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:59:54 INFO - '--tppagecycles', 17:59:54 INFO - '7'], 17:59:54 INFO - 'tests': ['tsvgm']}}, 17:59:54 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:59:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:59:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:59:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:59:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:59:54 INFO - 'talos_options': ['--disable-e10s'], 17:59:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:59:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:59:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:59:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:59:54 INFO - 'talos_options': ['--disable-e10s'], 17:59:54 INFO - 'tests': ['damp', 'tps']}, 17:59:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:59:54 INFO - 'tests': ['damp', 'tps']}, 17:59:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:59:54 INFO - 'tests': ['dromaeo_dom']}, 17:59:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:59:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:59:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:59:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:59:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:59:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:59:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:59:54 INFO - 'tests': ['a11yr', 17:59:54 INFO - 'ts_paint', 17:59:54 INFO - 'tpaint', 17:59:54 INFO - 'sessionrestore', 17:59:54 INFO - 'sessionrestore_no_auto_restore', 17:59:54 INFO - 'tabpaint']}, 17:59:54 INFO - 'other-e10s': {'tests': ['a11yr', 17:59:54 INFO - 'ts_paint', 17:59:54 INFO - 'tpaint', 17:59:54 INFO - 'sessionrestore', 17:59:54 INFO - 'sessionrestore_no_auto_restore', 17:59:54 INFO - 'tabpaint']}, 17:59:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:59:54 INFO - 'ts_paint', 17:59:54 INFO - 'tpaint', 17:59:54 INFO - 'sessionrestore', 17:59:54 INFO - 'sessionrestore_no_auto_restore', 17:59:54 INFO - 'tabpaint']}, 17:59:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:59:54 INFO - 'ts_paint', 17:59:54 INFO - 'tpaint', 17:59:54 INFO - 'sessionrestore', 17:59:54 INFO - 'sessionrestore_no_auto_restore', 17:59:54 INFO - 'tabpaint']}, 17:59:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:59:54 INFO - 'tests': ['a11yr', 17:59:54 INFO - 'ts_paint', 17:59:54 INFO - 'tpaint', 17:59:54 INFO - 'sessionrestore', 17:59:54 INFO - 'sessionrestore_no_auto_restore', 17:59:54 INFO - 'tabpaint']}, 17:59:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:59:54 INFO - 'tests': ['a11yr', 17:59:54 INFO - 'ts_paint', 17:59:54 INFO - 'tpaint', 17:59:54 INFO - 'sessionrestore', 17:59:54 INFO - 'sessionrestore_no_auto_restore', 17:59:54 INFO - 'tabpaint']}, 17:59:54 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:59:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:59:54 INFO - 'bloom_basic_ref']}, 17:59:54 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 17:59:54 INFO - 'talos_options': ['--mitmproxy', 17:59:54 INFO - 'mitmproxy-recording-1.mp', 17:59:54 INFO - '--firstNonBlankPaint'], 17:59:54 INFO - 'tests': ['Quantum_1']}, 17:59:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:59:54 INFO - 'tests': ['tsvgx', 17:59:54 INFO - 'tsvgr_opacity', 17:59:54 INFO - 'tart', 17:59:54 INFO - 'tscrollx', 17:59:54 INFO - 'cart', 17:59:54 INFO - 'tsvg_static']}, 17:59:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:59:54 INFO - 'tsvgr_opacity', 17:59:54 INFO - 'tart', 17:59:54 INFO - 'tscrollx', 17:59:54 INFO - 'cart', 17:59:54 INFO - 'tsvg_static']}, 17:59:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:59:54 INFO - 'talos_options': ['--disable-e10s'], 17:59:54 INFO - 'tests': ['tp5o']}, 17:59:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:59:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:59:54 INFO - 'talos_options': ['--disable-e10s', 17:59:54 INFO - '--xperf_path', 17:59:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:59:54 INFO - 'tests': ['tp5n']}, 17:59:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:59:54 INFO - 'talos_options': ['--xperf_path', 17:59:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:59:54 INFO - 'tests': ['tp5n']}}, 17:59:54 INFO - 'talos.zip': {'path': '', 17:59:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:59:54 INFO - Running post-action listener: _resource_record_post_action 17:59:54 INFO - [mozharness: 2017-06-07 00:59:54.669415Z] Finished populate-webroot step (success) 17:59:54 INFO - [mozharness: 2017-06-07 00:59:54.669504Z] Running create-virtualenv step. 17:59:54 INFO - Running pre-action listener: _resource_record_pre_action 17:59:54 INFO - Running main action method: create_virtualenv 17:59:54 INFO - Creating virtualenv /builds/slave/test/build/venv 17:59:54 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 17:59:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:59:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:59:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:59:54 INFO - Using real prefix '/usr' 17:59:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:59:55 INFO - Installing distribute.............................................................................................................................................................................................done. 17:59:57 INFO - Installing pip.................done. 17:59:57 INFO - Return code: 0 17:59:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:59:57 INFO - Reading from file tmpfile_stdout 17:59:57 INFO - Output received: 17:59:57 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) 17:59:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:59:57 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')]} 17:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:57 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')]} 17:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:57 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 0xd123b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10909a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e140>, '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 0x108ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eed0>, '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-1496789410.485969-1762224138', '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 17:59:57 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 17:59:57 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 17:59:57 INFO - Using env: {'DISPLAY': ':0', 17:59:57 INFO - 'HOME': '/home/cltbld', 17:59:57 INFO - 'LANG': 'en_US.UTF-8', 17:59:57 INFO - 'LANGUAGE': 'en_US:en', 17:59:57 INFO - 'LOGNAME': 'cltbld', 17:59:57 INFO - 'MAIL': '/var/mail/cltbld', 17:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:57 INFO - 'MOZ_NO_REMOTE': '1', 17:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:57 INFO - 'NO_EM_RESTART': '1', 17:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:57 INFO - 'PWD': '/builds/slave/test', 17:59:57 INFO - 'SHELL': '/bin/bash', 17:59:57 INFO - 'SHLVL': '1', 17:59:57 INFO - 'TERM': 'linux', 17:59:57 INFO - 'TMOUT': '86400', 17:59:57 INFO - 'USER': 'cltbld', 17:59:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496789410.485969-1762224138', 17:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:57 INFO - '_': '/tools/buildbot/bin/python'} 17:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:57 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 17:59:57 INFO - Cleaning up... 17:59:57 INFO - Return code: 0 17:59:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:59:57 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')]} 17:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:57 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')]} 17:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:57 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 0xd123b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10909a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e140>, '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 0x108ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eed0>, '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-1496789410.485969-1762224138', '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 17:59:57 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 17:59:57 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 17:59:57 INFO - Using env: {'DISPLAY': ':0', 17:59:57 INFO - 'HOME': '/home/cltbld', 17:59:57 INFO - 'LANG': 'en_US.UTF-8', 17:59:57 INFO - 'LANGUAGE': 'en_US:en', 17:59:57 INFO - 'LOGNAME': 'cltbld', 17:59:57 INFO - 'MAIL': '/var/mail/cltbld', 17:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:57 INFO - 'MOZ_NO_REMOTE': '1', 17:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:57 INFO - 'NO_EM_RESTART': '1', 17:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:57 INFO - 'PWD': '/builds/slave/test', 17:59:57 INFO - 'SHELL': '/bin/bash', 17:59:57 INFO - 'SHLVL': '1', 17:59:57 INFO - 'TERM': 'linux', 17:59:57 INFO - 'TMOUT': '86400', 17:59:57 INFO - 'USER': 'cltbld', 17:59:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496789410.485969-1762224138', 17:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:57 INFO - '_': '/tools/buildbot/bin/python'} 17:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:57 INFO - Downloading/unpacking psutil>=3.1.1 17:59:57 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 17:59:57 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 17:59:57 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 17:59:57 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 17:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:59:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:59:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:59:59 INFO - Installing collected packages: psutil 17:59:59 INFO - Running setup.py install for psutil 17:59:59 INFO - building 'psutil._psutil_linux' extension 17:59:59 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 17:59:59 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 17:59:59 INFO - building 'psutil._psutil_posix' extension 17:59:59 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 17:59:59 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 17:59:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:59:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:59:59 INFO - Successfully installed psutil 17:59:59 INFO - Cleaning up... 17:59:59 INFO - Return code: 0 17:59:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:59:59 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')]} 17:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:59 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')]} 17:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xd123b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10909a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e140>, '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 0x108ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eed0>, '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-1496789410.485969-1762224138', '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 17:59:59 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 17:59:59 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 17:59:59 INFO - Using env: {'DISPLAY': ':0', 17:59:59 INFO - 'HOME': '/home/cltbld', 17:59:59 INFO - 'LANG': 'en_US.UTF-8', 17:59:59 INFO - 'LANGUAGE': 'en_US:en', 17:59:59 INFO - 'LOGNAME': 'cltbld', 17:59:59 INFO - 'MAIL': '/var/mail/cltbld', 17:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:59 INFO - 'MOZ_NO_REMOTE': '1', 17:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:59 INFO - 'NO_EM_RESTART': '1', 17:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:59 INFO - 'PWD': '/builds/slave/test', 17:59:59 INFO - 'SHELL': '/bin/bash', 17:59:59 INFO - 'SHLVL': '1', 17:59:59 INFO - 'TERM': 'linux', 17:59:59 INFO - 'TMOUT': '86400', 17:59:59 INFO - 'USER': 'cltbld', 17:59:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496789410.485969-1762224138', 17:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:59 INFO - '_': '/tools/buildbot/bin/python'} 17:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:59:59 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 17:59:59 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 17:59:59 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 17:59:59 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:00:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:00:00 INFO - Installing collected packages: mozsystemmonitor 18:00:00 INFO - Running setup.py install for mozsystemmonitor 18:00:01 INFO - Successfully installed mozsystemmonitor 18:00:01 INFO - Cleaning up... 18:00:01 INFO - Return code: 0 18:00:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:00:01 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:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:01 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:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:01 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 0xd123b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10909a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e140>, '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 0x108ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eed0>, '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-1496789410.485969-1762224138', '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:00:01 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:00:01 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:00:01 INFO - Using env: {'DISPLAY': ':0', 18:00:01 INFO - 'HOME': '/home/cltbld', 18:00:01 INFO - 'LANG': 'en_US.UTF-8', 18:00:01 INFO - 'LANGUAGE': 'en_US:en', 18:00:01 INFO - 'LOGNAME': 'cltbld', 18:00:01 INFO - 'MAIL': '/var/mail/cltbld', 18:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:01 INFO - 'MOZ_NO_REMOTE': '1', 18:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:01 INFO - 'NO_EM_RESTART': '1', 18:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:01 INFO - 'PWD': '/builds/slave/test', 18:00:01 INFO - 'SHELL': '/bin/bash', 18:00:01 INFO - 'SHLVL': '1', 18:00:01 INFO - 'TERM': 'linux', 18:00:01 INFO - 'TMOUT': '86400', 18:00:01 INFO - 'USER': 'cltbld', 18:00:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496789410.485969-1762224138', 18:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:01 INFO - '_': '/tools/buildbot/bin/python'} 18:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:01 INFO - Downloading/unpacking jsonschema==2.5.1 18:00:01 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:00:01 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:00:01 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:00:01 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:00:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:00:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:00:02 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:00:02 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:00:02 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:00:02 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:00:02 INFO - Downloading functools32-3.2.3-2.tar.gz 18:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:00:02 INFO - warning: no files found matching '*.txt' 18:00:02 INFO - no previously-included directories found matching 'build' 18:00:02 INFO - no previously-included directories found matching 'dist' 18:00:02 INFO - no previously-included directories found matching '.git*' 18:00:02 INFO - Installing collected packages: jsonschema, functools32 18:00:02 INFO - Running setup.py install for functools32 18:00:02 INFO - warning: no files found matching '*.txt' 18:00:02 INFO - no previously-included directories found matching 'build' 18:00:02 INFO - no previously-included directories found matching 'dist' 18:00:02 INFO - no previously-included directories found matching '.git*' 18:00:02 INFO - Successfully installed jsonschema functools32 18:00:02 INFO - Cleaning up... 18:00:02 INFO - Return code: 0 18:00:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:00:02 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:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:02 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:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:02 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 0xd123b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10909a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e140>, '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 0x108ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eed0>, '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-1496789410.485969-1762224138', '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:00:02 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:00:02 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:00:02 INFO - Using env: {'DISPLAY': ':0', 18:00:02 INFO - 'HOME': '/home/cltbld', 18:00:02 INFO - 'LANG': 'en_US.UTF-8', 18:00:02 INFO - 'LANGUAGE': 'en_US:en', 18:00:02 INFO - 'LOGNAME': 'cltbld', 18:00:02 INFO - 'MAIL': '/var/mail/cltbld', 18:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:02 INFO - 'MOZ_NO_REMOTE': '1', 18:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:02 INFO - 'NO_EM_RESTART': '1', 18:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:02 INFO - 'PWD': '/builds/slave/test', 18:00:02 INFO - 'SHELL': '/bin/bash', 18:00:02 INFO - 'SHLVL': '1', 18:00:02 INFO - 'TERM': 'linux', 18:00:02 INFO - 'TMOUT': '86400', 18:00:02 INFO - 'USER': 'cltbld', 18:00:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496789410.485969-1762224138', 18:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:02 INFO - '_': '/tools/buildbot/bin/python'} 18:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:00:02 INFO - Cleaning up... 18:00:02 INFO - Return code: 0 18:00:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:00:02 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:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:02 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:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:02 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 0xd123b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10909a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e140>, '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 0x108ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eed0>, '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-1496789410.485969-1762224138', '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:00:02 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:00:02 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:00:02 INFO - Using env: {'DISPLAY': ':0', 18:00:02 INFO - 'HOME': '/home/cltbld', 18:00:02 INFO - 'LANG': 'en_US.UTF-8', 18:00:02 INFO - 'LANGUAGE': 'en_US:en', 18:00:02 INFO - 'LOGNAME': 'cltbld', 18:00:02 INFO - 'MAIL': '/var/mail/cltbld', 18:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:02 INFO - 'MOZ_NO_REMOTE': '1', 18:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:02 INFO - 'NO_EM_RESTART': '1', 18:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:02 INFO - 'PWD': '/builds/slave/test', 18:00:02 INFO - 'SHELL': '/bin/bash', 18:00:02 INFO - 'SHLVL': '1', 18:00:02 INFO - 'TERM': 'linux', 18:00:02 INFO - 'TMOUT': '86400', 18:00:02 INFO - 'USER': 'cltbld', 18:00:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496789410.485969-1762224138', 18:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:02 INFO - '_': '/tools/buildbot/bin/python'} 18:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:03 INFO - Downloading/unpacking blobuploader==1.2.4 18:00:03 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:00:03 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:00:03 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:00:03 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:00:04 INFO - Downloading blobuploader-1.2.4.tar.gz 18:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:00:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:00:04 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:00:04 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:00:04 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:00:04 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:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:00:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:00:04 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:00:04 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:00:04 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:00:04 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:00:04 INFO - Downloading docopt-0.6.1.tar.gz 18:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:00:04 INFO - Installing collected packages: blobuploader, requests, docopt 18:00:04 INFO - Running setup.py install for blobuploader 18:00:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:00:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:00:04 INFO - Running setup.py install for requests 18:00:05 INFO - Running setup.py install for docopt 18:00:05 INFO - Successfully installed blobuploader requests docopt 18:00:05 INFO - Cleaning up... 18:00:05 INFO - Return code: 0 18:00:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:05 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:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:05 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:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:05 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 0xd123b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10909a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e140>, '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 0x108ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eed0>, '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-1496789410.485969-1762224138', '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:00:05 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:00:05 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:00:05 INFO - Using env: {'DISPLAY': ':0', 18:00:05 INFO - 'HOME': '/home/cltbld', 18:00:05 INFO - 'LANG': 'en_US.UTF-8', 18:00:05 INFO - 'LANGUAGE': 'en_US:en', 18:00:05 INFO - 'LOGNAME': 'cltbld', 18:00:05 INFO - 'MAIL': '/var/mail/cltbld', 18:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:05 INFO - 'MOZ_NO_REMOTE': '1', 18:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:05 INFO - 'NO_EM_RESTART': '1', 18:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:05 INFO - 'PWD': '/builds/slave/test', 18:00:05 INFO - 'SHELL': '/bin/bash', 18:00:05 INFO - 'SHLVL': '1', 18:00:05 INFO - 'TERM': 'linux', 18:00:05 INFO - 'TMOUT': '86400', 18:00:05 INFO - 'USER': 'cltbld', 18:00:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496789410.485969-1762224138', 18:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:05 INFO - '_': '/tools/buildbot/bin/python'} 18:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:05 INFO - Running setup.py (path:/tmp/pip-gJktlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:05 INFO - Running setup.py (path:/tmp/pip-dyypW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:05 INFO - Running setup.py (path:/tmp/pip-WXnbG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:05 INFO - Running setup.py (path:/tmp/pip-GQXVWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:05 INFO - Running setup.py (path:/tmp/pip-bu6_KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:06 INFO - Running setup.py (path:/tmp/pip-PZXrLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:06 INFO - Running setup.py (path:/tmp/pip-7VzeOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:06 INFO - Running setup.py (path:/tmp/pip-mV53bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:06 INFO - Running setup.py (path:/tmp/pip-Js_cyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:06 INFO - Running setup.py (path:/tmp/pip-13OtW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:06 INFO - Running setup.py (path:/tmp/pip-FOjyGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:06 INFO - Running setup.py (path:/tmp/pip-xw_vWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:06 INFO - Running setup.py (path:/tmp/pip-33tfKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:06 INFO - Running setup.py (path:/tmp/pip-NkB2HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:06 INFO - Running setup.py (path:/tmp/pip-3NgtxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:06 INFO - Running setup.py (path:/tmp/pip-gazIbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:06 INFO - Running setup.py (path:/tmp/pip-jEzQBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:00:06 INFO - Running setup.py install for manifestparser 18:00:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:00:07 INFO - Running setup.py install for mozcrash 18:00:07 INFO - Running setup.py install for mozdebug 18:00:07 INFO - Running setup.py install for mozdevice 18:00:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:00:07 INFO - Running setup.py install for mozfile 18:00:07 INFO - Running setup.py install for mozhttpd 18:00:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:00:07 INFO - Running setup.py install for mozinfo 18:00:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:00:07 INFO - Running setup.py install for mozInstall 18:00:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:00:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:00:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:00:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:00:07 INFO - Running setup.py install for mozleak 18:00:07 INFO - Running setup.py install for mozlog 18:00:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:00:07 INFO - Running setup.py install for moznetwork 18:00:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:00:08 INFO - Running setup.py install for mozprocess 18:00:08 INFO - Running setup.py install for mozprofile 18:00:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:00:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:00:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:00:08 INFO - Running setup.py install for mozrunner 18:00:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:00:08 INFO - Running setup.py install for mozscreenshot 18:00:08 INFO - Running setup.py install for moztest 18:00:08 INFO - Running setup.py install for mozversion 18:00:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:00:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:00:08 INFO - Cleaning up... 18:00:08 INFO - Return code: 0 18:00:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00: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:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00: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:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:08 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 0xd123b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10909a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e140>, '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 0x108ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eed0>, '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-1496789410.485969-1762224138', '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:00:08 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:00:08 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:00:08 INFO - Using env: {'DISPLAY': ':0', 18:00:08 INFO - 'HOME': '/home/cltbld', 18:00:08 INFO - 'LANG': 'en_US.UTF-8', 18:00:08 INFO - 'LANGUAGE': 'en_US:en', 18:00:08 INFO - 'LOGNAME': 'cltbld', 18:00:08 INFO - 'MAIL': '/var/mail/cltbld', 18:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:08 INFO - 'MOZ_NO_REMOTE': '1', 18:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:08 INFO - 'NO_EM_RESTART': '1', 18:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:08 INFO - 'PWD': '/builds/slave/test', 18:00:08 INFO - 'SHELL': '/bin/bash', 18:00:08 INFO - 'SHLVL': '1', 18:00:08 INFO - 'TERM': 'linux', 18:00:08 INFO - 'TMOUT': '86400', 18:00:08 INFO - 'USER': 'cltbld', 18:00:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496789410.485969-1762224138', 18:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:08 INFO - '_': '/tools/buildbot/bin/python'} 18:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:08 INFO - Running setup.py (path:/tmp/pip-BodvOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:09 INFO - Running setup.py (path:/tmp/pip-QXIO3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:09 INFO - Running setup.py (path:/tmp/pip-jGetmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:09 INFO - Running setup.py (path:/tmp/pip-SIBcCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:09 INFO - Running setup.py (path:/tmp/pip-HN94is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:09 INFO - Running setup.py (path:/tmp/pip-FYb6sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:09 INFO - Running setup.py (path:/tmp/pip-J__My5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:09 INFO - Running setup.py (path:/tmp/pip-Bb78er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:09 INFO - Running setup.py (path:/tmp/pip-UUSFQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:09 INFO - Running setup.py (path:/tmp/pip-Ut8QRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:09 INFO - Running setup.py (path:/tmp/pip-D61YEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:09 INFO - Running setup.py (path:/tmp/pip-RCT0G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:09 INFO - Running setup.py (path:/tmp/pip-Vmm0wC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:09 INFO - Running setup.py (path:/tmp/pip-_wdLZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:09 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:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:09 INFO - Running setup.py (path:/tmp/pip-YH0jmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:10 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:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:10 INFO - Running setup.py (path:/tmp/pip-XIBKPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:10 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:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:10 INFO - Running setup.py (path:/tmp/pip-pKlYq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:10 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:00:10 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:00:10 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:00:10 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:00:10 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:00:10 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:00:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:00:10 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:00:10 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:00:10 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:00:10 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:00:11 INFO - Downloading blessings-1.6.tar.gz 18:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:00:11 INFO - Installing collected packages: blessings 18:00:11 INFO - Running setup.py install for blessings 18:00:11 INFO - Successfully installed blessings 18:00:11 INFO - Cleaning up... 18:00:11 INFO - Return code: 0 18:00:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:11 INFO - Reading from file tmpfile_stdout 18:00:11 INFO - Current package versions: 18:00:11 INFO - argparse == 1.2.1 18:00:11 INFO - blessings == 1.6 18:00:11 INFO - blobuploader == 1.2.4 18:00:11 INFO - docopt == 0.6.1 18:00:11 INFO - functools32 == 3.2.3-2 18:00:11 INFO - jsonschema == 2.5.1 18:00:11 INFO - manifestparser == 1.1 18:00:11 INFO - mozInstall == 1.12 18:00:11 INFO - mozcrash == 1.0 18:00:11 INFO - mozdebug == 0.1 18:00:11 INFO - mozdevice == 0.51 18:00:11 INFO - mozfile == 1.2 18:00:11 INFO - mozhttpd == 0.7 18:00:11 INFO - mozinfo == 0.10 18:00:11 INFO - mozleak == 0.1 18:00:11 INFO - mozlog == 3.4 18:00:11 INFO - moznetwork == 0.27 18:00:11 INFO - mozprocess == 0.25 18:00:11 INFO - mozprofile == 0.28 18:00:11 INFO - mozrunner == 6.13 18:00:11 INFO - mozscreenshot == 0.1 18:00:11 INFO - mozsystemmonitor == 0.3 18:00:11 INFO - moztest == 0.8 18:00:11 INFO - mozversion == 1.4 18:00:11 INFO - psutil == 3.1.1 18:00:11 INFO - requests == 1.2.3 18:00:11 INFO - wsgiref == 0.1.2 18:00:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00: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:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00: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:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:11 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 0xd123b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10909a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e140>, '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 0x108ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eed0>, '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-1496789410.485969-1762224138', '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:00:11 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:00:11 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:00:11 INFO - Using env: {'DISPLAY': ':0', 18:00:11 INFO - 'HOME': '/home/cltbld', 18:00:11 INFO - 'LANG': 'en_US.UTF-8', 18:00:11 INFO - 'LANGUAGE': 'en_US:en', 18:00:11 INFO - 'LOGNAME': 'cltbld', 18:00:11 INFO - 'MAIL': '/var/mail/cltbld', 18:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:11 INFO - 'MOZ_NO_REMOTE': '1', 18:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:11 INFO - 'NO_EM_RESTART': '1', 18:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:11 INFO - 'PWD': '/builds/slave/test', 18:00:11 INFO - 'SHELL': '/bin/bash', 18:00:11 INFO - 'SHLVL': '1', 18:00:11 INFO - 'TERM': 'linux', 18:00:11 INFO - 'TMOUT': '86400', 18:00:11 INFO - 'USER': 'cltbld', 18:00:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496789410.485969-1762224138', 18:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:11 INFO - '_': '/tools/buildbot/bin/python'} 18:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:11 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:00:11 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:00:11 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:00:11 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:00:11 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:00:11 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:00:11 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:00:11 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:00:11 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:00:11 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:00: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:00: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:00: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:00: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:00:13 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:00:13 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:00:13 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:00:13 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:00:13 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:00:13 INFO - Installing collected packages: marionette-driver 18:00:13 INFO - Running setup.py install for marionette-driver 18:00:13 INFO - Successfully installed marionette-driver 18:00:13 INFO - Cleaning up... 18:00:13 INFO - Return code: 0 18:00:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:00:13 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:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:13 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:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:13 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 0xd123b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10909a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e140>, '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 0x108ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eed0>, '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-1496789410.485969-1762224138', '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:00:13 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:00:13 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:00:13 INFO - Using env: {'DISPLAY': ':0', 18:00:13 INFO - 'HOME': '/home/cltbld', 18:00:13 INFO - 'LANG': 'en_US.UTF-8', 18:00:13 INFO - 'LANGUAGE': 'en_US:en', 18:00:13 INFO - 'LOGNAME': 'cltbld', 18:00:13 INFO - 'MAIL': '/var/mail/cltbld', 18:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:13 INFO - 'MOZ_NO_REMOTE': '1', 18:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:13 INFO - 'NO_EM_RESTART': '1', 18:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:13 INFO - 'PWD': '/builds/slave/test', 18:00:13 INFO - 'SHELL': '/bin/bash', 18:00:13 INFO - 'SHLVL': '1', 18:00:13 INFO - 'TERM': 'linux', 18:00:13 INFO - 'TMOUT': '86400', 18:00:13 INFO - 'USER': 'cltbld', 18:00:13 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496789410.485969-1762224138', 18:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:13 INFO - '_': '/tools/buildbot/bin/python'} 18:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:00:13 INFO - Cleaning up... 18:00:13 INFO - Return code: 0 18:00:13 INFO - Running post-action listener: _resource_record_post_action 18:00:13 INFO - Running post-action listener: _start_resource_monitoring 18:00:13 INFO - Starting resource monitoring. 18:00:13 INFO - [mozharness: 2017-06-07 01:00:13.505016Z] Finished create-virtualenv step (success) 18:00:13 INFO - [mozharness: 2017-06-07 01:00:13.505482Z] Running install step. 18:00:13 INFO - Running pre-action listener: _resource_record_pre_action 18:00:13 INFO - Running main action method: install 18:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:13 INFO - Reading from file tmpfile_stdout 18:00:13 INFO - Detecting whether we're running mozinstall >=1.0... 18:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:00:13 INFO - Reading from file tmpfile_stdout 18:00:13 INFO - Output received: 18:00:13 INFO - Usage: mozinstall [options] installer 18:00:13 INFO - Options: 18:00:13 INFO - -h, --help show this help message and exit 18:00:13 INFO - -d DEST, --destination=DEST 18:00:13 INFO - Directory to install application into. [default: 18:00:13 INFO - "/builds/slave/test"] 18:00:13 INFO - --app=APP Application being installed. [default: firefox] 18:00:13 INFO - mkdir: /builds/slave/test/build/application 18:00:13 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:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:00:31 INFO - Reading from file tmpfile_stdout 18:00:31 INFO - Output received: 18:00:31 INFO - /builds/slave/test/build/application/firefox/firefox 18:00:31 INFO - Running post-action listener: _resource_record_post_action 18:00:31 INFO - [mozharness: 2017-06-07 01:00:31.362235Z] Finished install step (success) 18:00:31 INFO - [mozharness: 2017-06-07 01:00:31.362391Z] Running setup-mitmproxy step. 18:00:31 INFO - Running pre-action listener: _resource_record_pre_action 18:00:31 INFO - Running main action method: setup_mitmproxy 18:00:31 INFO - Skipping: mitmproxy is not required 18:00:31 INFO - Running post-action listener: _resource_record_post_action 18:00:31 INFO - [mozharness: 2017-06-07 01:00:31.362927Z] Finished setup-mitmproxy step (success) 18:00:31 INFO - [mozharness: 2017-06-07 01:00:31.363031Z] Running run-tests step. 18:00:31 INFO - Running pre-action listener: _resource_record_pre_action 18:00:31 INFO - Running main action method: run_tests 18:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:00:31 INFO - Python 2.7.3 18:00:31 INFO - Return code: 0 18:00:31 INFO - grabbing minidump binary from tooltool 18:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/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 0x108e140>, '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 0x108ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108eed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:00:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:00:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:00:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:00:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:00:31 INFO - Return code: 0 18:00:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:00:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:00:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:00:31 INFO - ENV: RUST_BACKTRACE is now 1 18:00:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:00:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:00:31 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/NRSVz81RQ9iSzTtcJ00cnw/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:00:31 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/NRSVz81RQ9iSzTtcJ00cnw/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:00:31 INFO - Using env: {'DISPLAY': ':0', 18:00:31 INFO - 'HOME': '/home/cltbld', 18:00:31 INFO - 'LANG': 'en_US.UTF-8', 18:00:31 INFO - 'LANGUAGE': 'en_US:en', 18:00:31 INFO - 'LOGNAME': 'cltbld', 18:00:31 INFO - 'MAIL': '/var/mail/cltbld', 18:00:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:00:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:31 INFO - 'MOZ_NO_REMOTE': '1', 18:00:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:31 INFO - 'NO_EM_RESTART': '1', 18:00:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:31 INFO - 'PWD': '/builds/slave/test', 18:00:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:00:31 INFO - 'RUST_BACKTRACE': '1', 18:00:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:00:31 INFO - 'SHELL': '/bin/bash', 18:00:31 INFO - 'SHLVL': '1', 18:00:31 INFO - 'TERM': 'linux', 18:00:31 INFO - 'TMOUT': '86400', 18:00:31 INFO - 'USER': 'cltbld', 18:00:31 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1496789410.485969-1762224138', 18:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:31 INFO - '_': '/tools/buildbot/bin/python'} 18:00:31 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/NRSVz81RQ9iSzTtcJ00cnw/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:00:31 INFO - mozversion application_buildid: 20170607001930 18:00:31 INFO - mozversion application_changeset: 5801aa478de12a62b2b2982659e787fcc4268d67 18:00:31 INFO - mozversion application_display_name: Nightly 18:00:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:00:31 INFO - mozversion application_name: Firefox 18:00:31 INFO - mozversion application_remotingname: firefox 18:00:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:00:31 INFO - mozversion application_vendor: Mozilla 18:00:31 INFO - mozversion application_version: 55.0a1 18:00:31 INFO - mozversion platform_buildid: 20170607001930 18:00:31 INFO - mozversion platform_changeset: 5801aa478de12a62b2b2982659e787fcc4268d67 18:00:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:00:31 INFO - mozversion platform_version: 55.0a1 18:00:31 INFO - using testdate: 1496797231 18:00:31 INFO - actual date: 1496797231 18:00:31 INFO - starting webserver on 'localhost:45336' 18:00:31 INFO - SUITE-START | Running 2 tests 18:00:31 INFO - TEST-START | dromaeo_css 18:00:31 INFO - operating with platform_type : linux_ 18:00:31 INFO - Initialising browser for dromaeo_css test... 18:00:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45336/getInfo.html -profile /tmp/tmppsXDLb/profile 18:00:31 INFO - TEST-INFO | started process 30443 (/builds/slave/test/build/application/firefox/firefox http://localhost:45336/getInfo.html) 18:01:06 INFO - TEST-INFO | 30443: killed by SIGTERM 18:01:07 INFO - Browser initialized. 18:01:07 INFO - Running cycle 1/1 for dromaeo_css test... 18:01:07 INFO - TEST-INFO | started process 30671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppsXDLb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:18 INFO - PID 30671 | RSS: Main: 187846656 18:01:18 INFO - PID 30671 | 18:04:19 INFO - PID 30671 | Cycle 1(1): loaded http://localhost:45336/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45336/tests/dromaeo/cssquery-ext.html) 18:04:20 INFO - PID 30671 | RSS: Main: 184786944 18:04:20 INFO - PID 30671 | 18:07:22 INFO - PID 30671 | Cycle 1(1): loaded http://localhost:45336/tests/dromaeo/cssquery-ext.html (next: http://localhost:45336/tests/dromaeo/cssquery-jquery.html) 18:07:23 INFO - PID 30671 | RSS: Main: 189415424 18:07:23 INFO - PID 30671 | 18:10:25 INFO - PID 30671 | Cycle 1(1): loaded http://localhost:45336/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45336/tests/dromaeo/cssquery-mootools.html) 18:10:25 INFO - PID 30671 | RSS: Main: 189136896 18:10:25 INFO - PID 30671 | 18:13:27 INFO - PID 30671 | Cycle 1(1): loaded http://localhost:45336/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45336/tests/dromaeo/cssquery-prototype.html) 18:13:28 INFO - PID 30671 | RSS: Main: 192425984 18:13:28 INFO - PID 30671 | 18:16:30 INFO - PID 30671 | Cycle 1(1): loaded http://localhost:45336/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45336/tests/dromaeo/cssquery-yui.html) 18:16:31 INFO - PID 30671 | RSS: Main: 190767104 18:16:31 INFO - PID 30671 | 18:19:33 INFO - PID 30671 | Cycle 1(1): loaded http://localhost:45336/tests/dromaeo/cssquery-yui.html (next: http://localhost:45336/tests/dromaeo/cssquery-dojo.html) 18:19:33 INFO - PID 30671 | RSS: Main: 189259776 18:19:33 INFO - PID 30671 | 18:19:33 INFO - PID 30671 | __start_tp_report 18:19:33 INFO - PID 30671 | _x_x_mozilla_page_load 18:19:33 INFO - PID 30671 | _x_x_mozilla_page_load_details 18:19:33 INFO - PID 30671 | |i|pagename|runs| 18:19:33 INFO - PID 30671 | |0;dojo.html;3056.694330566943;3068.907932762018;3080.614923134608;3091.6908309169085;3104.798188117772;5826.796062137826;5849.093390524465;5874.236349274599;5894.6168499047535;5941.13853491244;5923.466887980081;5949.8215053548465;5999.370066143058;6069.999999999989;6091.421314975081;5459.727013649302;5514.393416724167;5559.9444005560035;5602.935442265977;5618.971905140468;5644.322681278252;5657.8585535361535;5659.952908711881;5660.830175094754;5685.459881311269;5411.134218525057;5486.039943009957;5508.476694714036;5540.86147846303;5575.581831362644;5534.4742249486235;5557.249771280865;5567.164925261202;5569.498745112959;5572.136318870582;5502.697351645658;5513.173024046425;5519.282493275889;5527.281453411031;5533.3083364579425;5841.766329346821;5959.523238140939;5980.491658209057;5989.3112292086535;5995.400459954013;6291.8741625167695;6352.904706429407;6401.135846660734;6405.359464053604;6440.5491615586925;6510.08858759774;6514.120593719835;6524.804255872332;6529.2164940207;6541.901871471931;6032.672811981357;6050.515958723292;6068.484178844759;6078.665673387962;6081.391860813927;6449.226092868886;6530.118434011348;6545;6619.86760264792;6646.468282537386;6167.475764560063;6172.475339596184;6249.781257656051;6352.047192921099;6362.427381535592;6449.806505804833;6461.903071453932;6462.063000864942;6470.191226096738;6506.642134682544;6455;6483.546151769331;6487.7080531376205;6495.350464953562;6499.577527460794;6288.119663247149;6316.968415157987;6383.010633351838;6391.648459334781;6452.354764523604;5236.083685355047;5248.107821670325;5255;5276.657017293864;5296.523312901781;4466.330050492387;4468.374427580141;4481.148581769454;4493.1013797240685;4500.819967201275;5507.944920550824;5566.944330556643;5618.0449323615085;5679.091345384719;5735.369109397963;6486.44865186455;6536.986767051115;6538.509611779135;6544.640044797487;6555.541112122106;5624.634398764068;5680.829575112753;5684.431556844283;5700.657960522382;5730.656160630376;5440.102383106743;5575.804846830341;5597.888042239214;5598;5601.859953501195;6164.815055548341;6191.504679625619;6305.1172835803945;6308.589941653778;6316.431521163117;6518.054882041983;6519.8044058678315;6522.086907832812;6526.24948130971;6537.411632953057;6260.593061450991;6305.337939516468;6313.747450101944;6317.810465686037;6334.144890439732;6180.907286390618;6219.191505104308;6305.653189074645;6372.936270637234;6386.808395748135;6545.574537655038;6549.24683661385;6553;6553.606783593;6584.144061272004;5960.403959604005;6066.908996364969;6287.371262873676;6292.433680968552;6313.494920406265;6188.133661287334;6270.717817698306;6288.465480434214;6300.0234963580715;6321.178246828067;6161.6919154041225;6204.100405441095;6212.81361559154;6216.347283535345;6234.064890266496;6173.382661733791;6241.001439769615;6347.841303967438;6361.427471527585;6378.585391949508;6122.755089796537;6183.165272688309;6188.319284878749;6192.133101365903;6205.286392064971 18:19:33 INFO - PID 30671 | |1;ext.html;732.6629750314855;789.6959670526848;813.9674413023478;1127.7349822791643;1142.8400023996637;35735.28529429413;36593;36613;36682.633173668255;36698.816505917435;38828.611713882856;39107;39407.80296098516;39415.60584394155;39416;7281.927180728205;7366.521176123548;7398.334149926505;7414.703411863546;7503.849923001537;7315.451341149408;7458.850822983537;7462.664180111881;7494.025776649028;7512;7496;7548.773536793905;7569.318761311481;7590.962045189766;7591.658375373121;7439.404847612205;7504.024476817979;7510.061242344707;7529.548227106391;7536.321731044178;7361.631918404112;7375.668094935741;7416.295451932057;7443.032405787213;7448.2179371165785;35832.64167358345;36029.639703602894;36036;36215.09462263438;36417.27165456703;3363.2768954674616;3403.7447191460737;3406.8296585170892;3411.4200585900207;3414.573178352706;28457.857710711312;28582;28620.856895715595;28627.284317892012;28692.856535717186;3179.300553878143;3335.69978701918;3355.781874178195;3375.0718552398043;3385.0521853880705;129071;132974;134193;167429;167594;38309.23381532354;38686;38769.61230387716;38771;38842.805785970886;40144.799276004014;40639.39040914389;40696;45113.77443112763;46628;15311.923440382727;15499.690006199813;15506.9224653876;15510.30203640839;15515;12545.874541254652;12631.305278209788;12638.2417054977;12676.23942563449;12709.364531773374;14601;14665.193414362098;14685.41258349654;14731.779023314659;14766.114033158045;5776.797812076557;5915.024021036566;5990.400959904062;6020.397960204032;6030.517558595302;946.8721722567503;958.8417911044739;972.3679608254549;1003.5634498992962;1027.635189507729;21692.45768855791;23304.368694191246;23675.881620592132;23854.88072559626;24186.758132418803;1065.9040686338267;1069.2248120112856;1097.2100087936833;1102.4928532874808;1106.0874778307927;11950.88049119515;15968.201589920458;16211.183525932493;16251.756223656655;16263.837361626469;198270;200819;201309;202355;202869;53294.73352633289;53363.19955200675;53474.73262633662;53574.46425535695;53699.46300536945;1398.4615922869566;1435.4258296681203;1435.8205224346957;1444.9638759030897;1446.2768615692155;25928.8703556481;27851.860740696167;27968.860155699906;28188.29529261703;28337.574936376383;35362.11594710153;35578.28843423065;35602.287954241285;35639.46540801838;35641.82179089088;181067;182385;182400;182597;182610.0869495644;28615.570766438937;28787.568186477638;28881.133565993056;28972.102789721703;29090.418191636472;34012.659873400946;34736.652633474354;34797;34818.47772283469;35005.9498215054;25127.87436062808;26710;27104.1868743938;30334.84832575823;32123;28547.42905141844;29407.705922940495;29527.557086643286;30346.241343965696;31101.377972439972;34263.48604770881;34311.65688343085;34362.82818585891;34744.82627586846;35212;28416.289592760346;29260.56109158407;29923.70076299209;30490.237744056576;31023.84488077545;21670.24154154597;24181;24287.51424971526;24489.265322040366;24554.140605078737 18:19:33 INFO - PID 30671 | |2;jquery.html;393.3215203773491;403.1714826032502;406.7539138821014;412.2065024827208;421.191312679655;14539.92730036351;15123.31945062472;19764;20393.592128157426;20456.69314960277;21289.361319160413;22051.889740551276;22186.556268874654;22212.1115155394;22218.00018999145;5815.709214539267;5890.469857712805;5920.763169473216;5945.672987985659;5954.434328738763;5807.5644326675665;5915.171875937351;5916.852078698024;5918.023526118185;5926.4073592640825;5599.188117722928;5827.592068555203;5845.941540584604;5852.824415267549;5863.648181109126;5817.505512031483;5834.708264586754;5840.970795146019;5844.620099693507;5847.707614619252;5219.739013049332;5238.92141617876;5247.737613119329;5279.076161671692;5280.287161233223;24456.510869782505;24615.63076553853;24851.13021044255;24872.12947546827;24898;1790.8656850736247;1821.9796913728221;1823.4985379020743;1826.1873466307497;1832.1846778183713;15540.533783986499;16365.42721004771;16414.6717065658;16487.093209873452;16518.174091295386;2149.4948687058527;2166.42589713726;2211.579799838026;2213.8118259947923;2216.0692509146197;114070.42964785123;118291;118957;119706;119853;10997.230193886351;11454.48454819535;11462;11475.131726009879;11643;16446.75329870053;16446.75329870053;16465.753013704805;16508.42220522276;16544.83455165457;8554.957225213959;8573.657053717907;8589.484630922165;8630.093840146694;8738.86891696625;8421.663133474593;8466.661333546712;8492.872606910902;8572.057073721886;8615.353848461391;7415.814604634819;7490.887636685454;7522.699092036257;7538.962305188439;7678.961605191938;1971.6488435712508;2063.9896800515903;2079.438551591092;2086.0925497408675;2187.7702841201444;913.7715571107224;914.3919293669635;916.7799728065216;944.5560586524323;976.3995142987012;17267.568310792332;17328.48014559565;17813;18076.548086297684;18365.7245141323;912.3431129586687;933.780561568031;951.5955718819474;957.1146689312358;983.0759086458706;9388.028921410265;9528.333016688764;9699.321047526606;9873.506324683736;10343.120834728981;405357;411640;412399;416042;419644;93138.53430732939;95723;97004.51497742467;97241;97587.51206243923;1097.8078836203633;1119.972000699989;1131.2759833706434;1134.7049767060623;1148.6152139033518;15225.847741522442;15636.92181539085;15869.285882135562;16261;16833;44494;44929.32606010978;45691.54308456873;46095;47457.28814067723;58213.41786582249;58731;59166.70416647889;59271.40728592659;59437;9807.362521436084;10014.599416023277;10166.186705063725;10174.13519850821;10180.236482263712;16599;16651.91674041622;16887.240074196445;17934;18424.907875460536;14066.648333791327;14167.079139855876;14302.356393962089;15231.314590843216;15321.540353789404;13377.53178638743;13516.93241533786;13577.660558486117;13833.515826946008;13959.651008724863;14249.857501424853;14569.854301457273;14654.047486913316;14677.045992010486;14782.852171478578;16292.918535407247;16653;16777.41279055276;16821.831781682515;16826.990380577205;13693.520726774914;13793.517226897411;14219.786703199667;14443.78334324965;14534 18:19:33 INFO - PID 30671 | |3;mootools.html;1326.1380102933094;1378.2695171559064;1381.4336122189904;1391.6868704541473;1393.8745512903836;10407.635732749355;10749.301295415802;10785.83821242682;10929.180311476652;11283;10972.341659500436;11297.774044519105;11314.094872410207;11317.264377815436;11333.263337883032;2321.779430954057;2355.093289083698;2359.7876191142796;2364.3498038039506;2370.3600027992434;2289.919852805152;2332.1371092695726;2333.556624241397;2335.4469277930243;2340.438294809242;2252.932412027642;2273.533925545259;2289.1072481732053;2301.8043466305385;2302.804261637763;2155.374941267031;2228.832837537183;2229.030371788277;2232.5088480534337;2234.6312858378346;2142.6250406178856;2218.8779617121054;2245.124401483423;2278.2254033628647;2294.128231272123;10914.126869850394;10983.176261780398;10989.340639561571;11001.394923279217;11002.064824489928;5786.421357864222;5942.435468630473;5977.133315669247;6010.8497287567725;6018.969905150446;3426.674465925733;3587.515685382492;3619.6199399062984;3626.2928728897878;3651.361011822947;1201.1831954271092;1214.4474264209853;1219.3842109734617;1263.5830176041884;1266.8163116348078;15809.130497822614;15933.521994340072;15955.521334359988;15995.200239988071;16030.438934637348;4790.353302304214;4831.589314908202;4840.056189043103;4886.755662216875;4899.853004409873;11742.119341049456;11794.174407791372;11834.17160798753;11840.585579504675;11842.76314473723;5868.383819698955;6099.878002440015;6133.355997620275;6140.6929653517145;6142.109394137825;5641.153826925912;5722.399148089474;5743.4543718346695;5769.336526299529;5784.4504772046585;4050.331695270306;4101.651359634405;4143.772092534879;4174;4204.474440694913;1147.5008371358485;1148.534843388429;1164.7262893220086;1167.2121318110242;1179.6932797472718;813.6989313953875;832.4672209785742;835.7325655790089;842.2588122452325;864.9308055355557;5463.644863083887;5764.962346413017;5915.260592425947;5982.641041537521;6006.459418652343;594.6164723753155;598.3119412675458;606.5572132343414;614.6803662095685;614.7786796753165;3799.5820459749407;3813.2945405100145;3960.663343615767;4015.8393664253686;4165.937510937339;13577;14025;14141.717165656835;14146.71706565863;14179.220142892034;13741.381637826322;13961.301934903215;13961.952853536026;13963.860361396459;13969.441222351195;8211.8357632847;8613.440126391764;8617.95691021541;8630.913690863137;8633.136686331316;6507.674616269073;6522.34776522344;6640.269570347355;6852.6231057292325;7116.074910261633;12283.201591896499;12626.747465050465;12737.363131843185;12756.425960831599;12969.157004794659;13120.475180992653;13165.275909825052;13279.80080298777;13285.667858303234;13329;8611.913880861111;8735.868961965703;9035.819283614423;9129.406588571721;9138.360314777901;10701.946490267499;10846.566137354417;10846.728831779268;10883.945580272048;10893.237473376788;8770.517621530622;8792.47245165292;9060.275177985613;9146.131117543822;9197.908020919705;8687.261582765283;8724.607392667218;8764;8780.341474389574;9017.05320941318;7470;7476.140243872024;7530.548167109991;7541.849163016599;7573.242675732383;5612.382637909745;5669.376368599534;5793.420657934173;5983.34183239852;6013.188219590475;5306.381553626181;5535.972320138535;5595.300587426572;5707.429257074426;5799.217105690678 18:19:33 INFO - PID 30671 | |4;prototype.html;387.35312028911716;398.2711637703004;401.6124439915481;408.7200267816546;409.7091065343606;6102.450779429851;6322.494200463963;6324.905126423101;6332.810015699531;6406.3233839297345;6040.365761595035;6085.665288409146;6115.541334399915;6119.755209791603;6160.1683772690785;4750.311204875291;4760.262159365304;4762.761861906908;4764.690295130806;4776.331313616097;4773.928391074137;4783.091212669582;4792.329073929653;4797.304390863323;4800.183968725308;4718.90562188756;4741.478437371887;4748.121597504455;4758.500357462469;4759.785809638574;4734.171519984006;4738.691985020962;4740.739259340735;4744.810207591692;4745.620350371962;4121.794839760743;4135.483064616923;4149.190907772985;4152.522459917088;4160.604742549453;6102.511799056109;6114.480269177081;6120.632762034292;6127.958247098004;6147.538934579879;5436.401995780461;5444.972775136099;5451.3458384993655;5454.10007348787;5455.5908306876745;6561.7375304987745;6564.704588293538;6566.474682025427;6580.88125018748;6584.76953306632;4535.750533720644;4542.955120322311;4545.863624091249;4552.613027892633;4557.589816916494;6490.545661803676;6851.417629501499;6867.381935625767;6897.896531551981;6977.686004129776;4554.24854898938;4572.908541829145;4589.288660257599;4592.448906131219;4598.839040633628;4559.247724125548;4608.953910460919;4613.446386433649;4632.826513838032;4635.420572428447;5172.715500647425;5311.575073994149;5351.946480535223;5378.784848606012;5414.945850541523;6605.900911486331;6614.206295244601;6623.370779775913;6629.668516574152;6640.933590664032;1601.54356008537;1613.4191690991233;1620.9270582823801;1626.4795265515158;1628.364937674308;1051.363924825485;1083.664064140119;1085.9565617375374;1093.6609651008214;1097.3799803111217;5798.739056742456;5844.415558444207;5849.1226316052935;5863.882722345615;5877.147813567009;6798.218204906499;6806.625635589991;6810.31896810315;6818.147731533559;6827.146606674166;5738.598298119092;5779.757352169219;5791.594588378857;5825.38833422493;5861.238039054895;3608.512850765113;3608.6030536640947;3617.2584620152807;3639.1993761372455;3642.9799656096334;6553.967230163818;6574.934250657528;6588.143541339691;6598.7030583623855;6600.669966501751;6970.686319115652;6977.441804655616;6995.580265184003;7036.683349249296;7046.260142684944;6588.4070433660245;6622.602643841385;6629.5359324846795;6633.568818026813;6649.667516624149;6785.287544807921;6816.7614133505085;6838.692258848463;6860.382565568923;6870.965645171742;6422.293547709842;6766.391024807791;6797.626130562867;6800.761973330909;6820.795376138723;6552.08270842092;6594.175728033996;6610.471162306908;6622.701978410887;6623.138991931018;4625.653076019379;4637.62898968075;4637.721736695809;4638.628909687284;4647.419072615923;6636.701348439428;6766.695498702472;6811.761588344384;6821.624810635462;6869.175698916162;6546.9883853427955;6653.966730166512;6666.400023997863;6668.899966500603;6681.716928547906;6578.177727784027;6624.370684784938;6636.601803891782;6657.933420665731;6678.799636010927;6375.5654977629665;6469.385408386196;6488.318726533646;6490.675466226764;6544.9672751635935;6589.275179730322;6606.174228221473;6654.73381064752;6661.866762664817;6680.766173183915;6411.326810684997;6437.549371543947;6466.353364663496;6480.7686539557335;6480.8703825922275 18:19:33 INFO - PID 30671 | |5;yui.html;814.8288859339539;848.7793173774819;854.8375808596367;860.4708104515721;866.2333834556417;15130.470433534829;15899.443519476821;15923.12422816746;18639.813601863978;19863.900680496612;18085;18213;18448.815511844878;18470.53823654406;18488.168032438538;955.4410669758182;980.8871979722352;983.2134292565954;986.8865080515725;989;931.0549791961165;990.2474119669031;999.2755252441958;1001.9098281154695;1016.9338992965434;1060.512164404371;1062.0812996757827;1064.6912395405323;1066.1204506282347;1067.4555976451988;1054.620336678795;1059.464970190053;1060.9045185933264;1061.0927656853357;1063.8404239364118;772.8763397856316;774.1716363491067;775.5463054113351;776.3245976000859;777.315961953483;16877.324907003705;17205.397811076677;17423.39018134372;17447.21487533064;17453.301867925267;18663.53341166468;18830.62338753231;19239.51901202467;19287.710684339745;19296.517587060294;15339.309731062129;15511.922440387838;15531;15556.922215388851;15599.220038998119;3339.365520551112;3350.279689866666;3394.2023624448234;3405.744569157323;3413.061408112764;80134;81764.59117704433;99075.50462247715;100152;101008;14455.13269203851;14957.700845983238;14960.551183464513;15043.247837608076;15097.39610415593;27243.182704518895;27369.45261094767;27451.862740686167;27818.72181278202;27862.442751144863;7749.922500775033;8105.432619716563;8130.065042520186;8172.468789528662;8219.630116644765;3630.3828349180703;3695.2055308108884;3708.2212735325343;3713.1459764254373;3719.795411252407;4236.661067114624;4312.072904325522;4339;4343.543927887589;4361.934570981438;870.0690261420347;876.4522173641474;877.5173654490005;887.7824932891483;890.238845786843;636.9076483909807;665.70043480434;679.4496457869142;694.1150033707064;698.7624207769383;9551;10493.842592361121;10522.105621022145;11048.834267485994;12165.270083794823;674.1236392689484;690.6236101324689;693.715576613586;699.1679900917892;705.3651713457929;4866;4907.386576677915;5009.44896061433;5046.520580544842;5172.431032586413;91363;91484;91969.54015229881;92287.5385623081;93515;82188.17811821925;82609.58695206486;82613.17386826174;82845;83479;68867;73508.63245683844;73740;73957.78126656209;74166.62916685382;9659.613615455302;9773.804523909625;9783.36408133469;10114.797704046025;10271.537780799732;33333.66666333305;33342.16644583905;33466.83266583652;33699;34023.65976340205;40479.392809107296;40644.3903341456;40963.7951810239;41275.793621031706;41840;14666.77999829982;14757.704845903236;14849.480268190562;15032.6993460128;15140.848591514385;16515.17424128813;16659.75010374821;16743;16751.581210469834;17055;14930.850691492946;15149.469768558047;15192.164430955962;15358.769618455508;15676.76484852751;15197.6200594986;15321.310541025903;15437.459688910834;15501.379944802082;15644.608884777972;14939.850601493847;14974.47589334368;15394.692106158038;15572.14353210539;15799.763003554726;11197.44012799373;11301.886981130083;11556.94221528887;11633.41832908368;11740.647780566254;10720.892791072301;10803.837942430713;11048.613298534512;11068.28056176346;11407.771844563229 18:19:33 INFO - PID 30671 | __end_tp_report 18:19:33 INFO - PID 30671 | __start_cc_report 18:19:33 INFO - PID 30671 | _x_x_mozilla_cycle_collect,377 18:19:33 INFO - PID 30671 | __end_cc_report 18:19:33 INFO - PID 30671 | __startTimestamp1496798373528__endTimestamp 18:19:33 INFO - PID 30671 | 18:19:33 INFO - PID 30671 | ------- Summary: start ------- 18:19:33 INFO - PID 30671 | Number of tests: 6 18:19:33 INFO - PID 30671 | 18:19:33 INFO - PID 30671 | [#0] dojo.html Cycles:165 Average:5940.76 Median:6173.38 stddev:688.83 (11.2%) stddev-sans-first:652.73 18:19:33 INFO - PID 30671 | Values: 3056.7 3068.9 3080.6 3091.7 3104.8 5826.8 5849.1 5874.2 5894.6 5941.1 5923.5 5949.8 5999.4 6070.0 6091.4 5459.7 5514.4 5559.9 5602.9 5619.0 5644.3 5657.9 5660.0 5660.8 5685.5 5411.1 5486.0 5508.5 5540.9 5575.6 5534.5 5557.2 5567.2 5569.5 5572.1 5502.7 5513.2 5519.3 5527.3 5533.3 5841.8 5959.5 5980.5 5989.3 5995.4 6291.9 6352.9 6401.1 6405.4 6440.5 6510.1 6514.1 6524.8 6529.2 6541.9 6032.7 6050.5 6068.5 6078.7 6081.4 6449.2 6530.1 6545.0 6619.9 6646.5 6167.5 6172.5 6249.8 6352.0 6362.4 6449.8 6461.9 6462.1 6470.2 6506.6 6455.0 6483.5 6487.7 6495.4 6499.6 6288.1 6317.0 6383.0 6391.6 6452.4 5236.1 5248.1 5255.0 5276.7 5296.5 4466.3 4468.4 4481.1 4493.1 4500.8 5507.9 5566.9 5618.0 5679.1 5735.4 6486.4 6537.0 6538.5 6544.6 6555.5 5624.6 5680.8 5684.4 5700.7 5730.7 5440.1 5575.8 5597.9 5598.0 5601.9 6164.8 6191.5 6305.1 6308.6 6316.4 6518.1 6519.8 6522.1 6526.2 6537.4 6260.6 6305.3 6313.7 6317.8 6334.1 6180.9 6219.2 6305.7 6372.9 6386.8 6545.6 6549.2 6553.0 6553.6 6584.1 5960.4 6066.9 6287.4 6292.4 6313.5 6188.1 6270.7 6288.5 6300.0 6321.2 6161.7 6204.1 6212.8 6216.3 6234.1 6173.4 6241.0 6347.8 6361.4 6378.6 6122.8 6183.2 6188.3 6192.1 6205.3 18:19:33 INFO - PID 30671 | 18:19:33 INFO - PID 30671 | [#1] ext.html Cycles:180 Average:33715.02 Median:3345.74 stddev:46001.03 (1374.9%) stddev-sans-first:46063.41 18:19:33 INFO - PID 30671 | Values: 732.7 789.7 814.0 1127.7 1142.8 35735.3 36593.0 36613.0 36682.6 36698.8 38828.6 39107.0 39407.8 39415.6 39416.0 7281.9 7366.5 7398.3 7414.7 7503.8 7315.5 7458.9 7462.7 7494.0 7512.0 7496.0 7548.8 7569.3 7591.0 7591.7 7439.4 7504.0 7510.1 7529.5 7536.3 7361.6 7375.7 7416.3 7443.0 7448.2 35832.6 36029.6 36036.0 36215.1 36417.3 3363.3 3403.7 3406.8 3411.4 3414.6 28457.9 28582.0 28620.9 28627.3 28692.9 3179.3 3335.7 3355.8 3375.1 3385.1 129071.0 132974.0 134193.0 167429.0 167594.0 38309.2 38686.0 38769.6 38771.0 38842.8 40144.8 40639.4 40696.0 45113.8 46628.0 15311.9 15499.7 15506.9 15510.3 15515.0 12545.9 12631.3 12638.2 12676.2 12709.4 14601.0 14665.2 14685.4 14731.8 14766.1 5776.8 5915.0 5990.4 6020.4 6030.5 946.9 958.8 972.4 1003.6 1027.6 21692.5 23304.4 23675.9 23854.9 24186.8 1065.9 1069.2 1097.2 1102.5 1106.1 11950.9 15968.2 16211.2 16251.8 16263.8 198270.0 200819.0 201309.0 202355.0 202869.0 53294.7 53363.2 53474.7 53574.5 53699.5 1398.5 1435.4 1435.8 1445.0 1446.3 25928.9 27851.9 27968.9 28188.3 28337.6 35362.1 35578.3 35602.3 35639.5 35641.8 181067.0 182385.0 182400.0 182597.0 182610.1 28615.6 28787.6 28881.1 28972.1 29090.4 34012.7 34736.7 34797.0 34818.5 35005.9 25127.9 26710.0 27104.2 30334.8 32123.0 28547.4 29407.7 29527.6 30346.2 31101.4 34263.5 34311.7 34362.8 34744.8 35212.0 28416.3 29260.6 29923.7 30490.2 31023.8 21670.2 24181.0 24287.5 24489.3 24554.1 18:19:33 INFO - PID 30671 | 18:19:33 INFO - PID 30671 | [#2] jquery.html Cycles:180 Average:29121.12 Median:2214.94 stddev:69615.72 (3143.0%) stddev-sans-first:69777.59 18:19:33 INFO - PID 30671 | Values: 393.3 403.2 406.8 412.2 421.2 14539.9 15123.3 19764.0 20393.6 20456.7 21289.4 22051.9 22186.6 22212.1 22218.0 5815.7 5890.5 5920.8 5945.7 5954.4 5807.6 5915.2 5916.9 5918.0 5926.4 5599.2 5827.6 5845.9 5852.8 5863.6 5817.5 5834.7 5841.0 5844.6 5847.7 5219.7 5238.9 5247.7 5279.1 5280.3 24456.5 24615.6 24851.1 24872.1 24898.0 1790.9 1822.0 1823.5 1826.2 1832.2 15540.5 16365.4 16414.7 16487.1 16518.2 2149.5 2166.4 2211.6 2213.8 2216.1 114070.4 118291.0 118957.0 119706.0 119853.0 10997.2 11454.5 11462.0 11475.1 11643.0 16446.8 16446.8 16465.8 16508.4 16544.8 8555.0 8573.7 8589.5 8630.1 8738.9 8421.7 8466.7 8492.9 8572.1 8615.4 7415.8 7490.9 7522.7 7539.0 7679.0 1971.6 2064.0 2079.4 2086.1 2187.8 913.8 914.4 916.8 944.6 976.4 17267.6 17328.5 17813.0 18076.5 18365.7 912.3 933.8 951.6 957.1 983.1 9388.0 9528.3 9699.3 9873.5 10343.1 405357.0 411640.0 412399.0 416042.0 419644.0 93138.5 95723.0 97004.5 97241.0 97587.5 1097.8 1120.0 1131.3 1134.7 1148.6 15225.8 15636.9 15869.3 16261.0 16833.0 44494.0 44929.3 45691.5 46095.0 47457.3 58213.4 58731.0 59166.7 59271.4 59437.0 9807.4 10014.6 10166.2 10174.1 10180.2 16599.0 16651.9 16887.2 17934.0 18424.9 14066.6 14167.1 14302.4 15231.3 15321.5 13377.5 13516.9 13577.7 13833.5 13959.7 14249.9 14569.9 14654.0 14677.0 14782.9 16292.9 16653.0 16777.4 16821.8 16827.0 13693.5 13793.5 14219.8 14443.8 14534.0 18:19:33 INFO - PID 30671 | 18:19:33 INFO - PID 30671 | [#3] mootools.html Cycles:180 Average:6753.58 Median:3507.10 stddev:4351.26 (124.1%) stddev-sans-first:4344.35 18:19:33 INFO - PID 30671 | Values: 1326.1 1378.3 1381.4 1391.7 1393.9 10407.6 10749.3 10785.8 10929.2 11283.0 10972.3 11297.8 11314.1 11317.3 11333.3 2321.8 2355.1 2359.8 2364.3 2370.4 2289.9 2332.1 2333.6 2335.4 2340.4 2252.9 2273.5 2289.1 2301.8 2302.8 2155.4 2228.8 2229.0 2232.5 2234.6 2142.6 2218.9 2245.1 2278.2 2294.1 10914.1 10983.2 10989.3 11001.4 11002.1 5786.4 5942.4 5977.1 6010.8 6019.0 3426.7 3587.5 3619.6 3626.3 3651.4 1201.2 1214.4 1219.4 1263.6 1266.8 15809.1 15933.5 15955.5 15995.2 16030.4 4790.4 4831.6 4840.1 4886.8 4899.9 11742.1 11794.2 11834.2 11840.6 11842.8 5868.4 6099.9 6133.4 6140.7 6142.1 5641.2 5722.4 5743.5 5769.3 5784.5 4050.3 4101.7 4143.8 4174.0 4204.5 1147.5 1148.5 1164.7 1167.2 1179.7 813.7 832.5 835.7 842.3 864.9 5463.6 5765.0 5915.3 5982.6 6006.5 594.6 598.3 606.6 614.7 614.8 3799.6 3813.3 3960.7 4015.8 4165.9 13577.0 14025.0 14141.7 14146.7 14179.2 13741.4 13961.3 13962.0 13963.9 13969.4 8211.8 8613.4 8618.0 8630.9 8633.1 6507.7 6522.3 6640.3 6852.6 7116.1 12283.2 12626.7 12737.4 12756.4 12969.2 13120.5 13165.3 13279.8 13285.7 13329.0 8611.9 8735.9 9035.8 9129.4 9138.4 10701.9 10846.6 10846.7 10883.9 10893.2 8770.5 8792.5 9060.3 9146.1 9197.9 8687.3 8724.6 8764.0 8780.3 9017.1 7470.0 7476.1 7530.5 7541.8 7573.2 5612.4 5669.4 5793.4 5983.3 6013.2 5306.4 5536.0 5595.3 5707.4 5799.2 18:19:33 INFO - PID 30671 | 18:19:33 INFO - PID 30671 | [#4] prototype.html Cycles:180 Average:5445.82 Median:6117.65 stddev:1633.23 (26.7%) stddev-sans-first:1593.07 18:19:33 INFO - PID 30671 | Values: 387.4 398.3 401.6 408.7 409.7 6102.5 6322.5 6324.9 6332.8 6406.3 6040.4 6085.7 6115.5 6119.8 6160.2 4750.3 4760.3 4762.8 4764.7 4776.3 4773.9 4783.1 4792.3 4797.3 4800.2 4718.9 4741.5 4748.1 4758.5 4759.8 4734.2 4738.7 4740.7 4744.8 4745.6 4121.8 4135.5 4149.2 4152.5 4160.6 6102.5 6114.5 6120.6 6128.0 6147.5 5436.4 5445.0 5451.3 5454.1 5455.6 6561.7 6564.7 6566.5 6580.9 6584.8 4535.8 4543.0 4545.9 4552.6 4557.6 6490.5 6851.4 6867.4 6897.9 6977.7 4554.2 4572.9 4589.3 4592.4 4598.8 4559.2 4609.0 4613.4 4632.8 4635.4 5172.7 5311.6 5351.9 5378.8 5414.9 6605.9 6614.2 6623.4 6629.7 6640.9 1601.5 1613.4 1620.9 1626.5 1628.4 1051.4 1083.7 1086.0 1093.7 1097.4 5798.7 5844.4 5849.1 5863.9 5877.1 6798.2 6806.6 6810.3 6818.1 6827.1 5738.6 5779.8 5791.6 5825.4 5861.2 3608.5 3608.6 3617.3 3639.2 3643.0 6554.0 6574.9 6588.1 6598.7 6600.7 6970.7 6977.4 6995.6 7036.7 7046.3 6588.4 6622.6 6629.5 6633.6 6649.7 6785.3 6816.8 6838.7 6860.4 6871.0 6422.3 6766.4 6797.6 6800.8 6820.8 6552.1 6594.2 6610.5 6622.7 6623.1 4625.7 4637.6 4637.7 4638.6 4647.4 6636.7 6766.7 6811.8 6821.6 6869.2 6547.0 6654.0 6666.4 6668.9 6681.7 6578.2 6624.4 6636.6 6657.9 6678.8 6375.6 6469.4 6488.3 6490.7 6545.0 6589.3 6606.2 6654.7 6661.9 6680.8 6411.3 6437.5 6466.4 6480.8 6480.9 18:19:33 INFO - PID 30671 | 18:19:33 INFO - PID 30671 | [#5] yui.html Cycles:180 Average:19382.04 Median:33337.92 stddev:25290.43 (75.9%) stddev-sans-first:25322.94 18:19:33 INFO - PID 30671 | Values: 814.8 848.8 854.8 860.5 866.2 15130.5 15899.4 15923.1 18639.8 19863.9 18085.0 18213.0 18448.8 18470.5 18488.2 955.4 980.9 983.2 986.9 989.0 931.1 990.2 999.3 1001.9 1016.9 1060.5 1062.1 1064.7 1066.1 1067.5 1054.6 1059.5 1060.9 1061.1 1063.8 772.9 774.2 775.5 776.3 777.3 16877.3 17205.4 17423.4 17447.2 17453.3 18663.5 18830.6 19239.5 19287.7 19296.5 15339.3 15511.9 15531.0 15556.9 15599.2 3339.4 3350.3 3394.2 3405.7 3413.1 80134.0 81764.6 99075.5 100152.0 101008.0 14455.1 14957.7 14960.6 15043.2 15097.4 27243.2 27369.5 27451.9 27818.7 27862.4 7749.9 8105.4 8130.1 8172.5 8219.6 3630.4 3695.2 3708.2 3713.1 3719.8 4236.7 4312.1 4339.0 4343.5 4361.9 870.1 876.5 877.5 887.8 890.2 636.9 665.7 679.4 694.1 698.8 9551.0 10493.8 10522.1 11048.8 12165.3 674.1 690.6 693.7 699.2 705.4 4866.0 4907.4 5009.4 5046.5 5172.4 91363.0 91484.0 91969.5 92287.5 93515.0 82188.2 82609.6 82613.2 82845.0 83479.0 68867.0 73508.6 73740.0 73957.8 74166.6 9659.6 9773.8 9783.4 10114.8 10271.5 33333.7 33342.2 33466.8 33699.0 34023.7 40479.4 40644.4 40963.8 41275.8 41840.0 14666.8 14757.7 14849.5 15032.7 15140.8 16515.2 16659.8 16743.0 16751.6 17055.0 14930.9 15149.5 15192.2 15358.8 15676.8 15197.6 15321.3 15437.5 15501.4 15644.6 14939.9 14974.5 15394.7 15572.1 15799.8 11197.4 11301.9 11556.9 11633.4 11740.6 10720.9 10803.8 11048.6 11068.3 11407.8 18:19:33 INFO - PID 30671 | -------- Summary: end -------- 18:19:33 INFO - PID 30671 | 18:19:34 INFO - TEST-INFO | 30671: exit 0 18:19:34 INFO - TEST-OK | dromaeo_css | took 1142875ms 18:19:34 INFO - TEST-START | kraken 18:19:34 INFO - operating with platform_type : linux_ 18:19:34 INFO - Initialising browser for kraken test... 18:19:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45336/getInfo.html -profile /tmp/tmpoEtTV8/profile 18:19:34 INFO - TEST-INFO | started process 31094 (/builds/slave/test/build/application/firefox/firefox http://localhost:45336/getInfo.html) 18:20:09 INFO - TEST-INFO | 31094: killed by SIGTERM 18:20:09 INFO - Browser initialized. 18:20:09 INFO - Running cycle 1/1 for kraken test... 18:20:09 INFO - TEST-INFO | started process 31321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoEtTV8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:21 INFO - PID 31321 | RSS: Main: 188018688 18:20:21 INFO - PID 31321 | 18:20:24 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45336/tests/kraken/driver.html?testName=audio-beat-detection) 18:20:24 INFO - PID 31321 | RSS: Main: 193380352 18:20:24 INFO - PID 31321 | 18:20:27 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45336/tests/kraken/driver.html?testName=audio-dft) 18:20:28 INFO - PID 31321 | RSS: Main: 191614976 18:20:28 INFO - PID 31321 | 18:20:31 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45336/tests/kraken/driver.html?testName=audio-fft) 18:20:31 INFO - PID 31321 | RSS: Main: 188940288 18:20:31 INFO - PID 31321 | 18:20:33 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45336/tests/kraken/driver.html?testName=audio-oscillator) 18:20:34 INFO - PID 31321 | RSS: Main: 188780544 18:20:34 INFO - PID 31321 | 18:20:36 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45336/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:20:37 INFO - PID 31321 | RSS: Main: 188698624 18:20:37 INFO - PID 31321 | 18:20:40 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45336/tests/kraken/driver.html?testName=imaging-darkroom) 18:20:40 INFO - PID 31321 | RSS: Main: 190009344 18:20:40 INFO - PID 31321 | 18:20:44 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45336/tests/kraken/driver.html?testName=imaging-desaturate) 18:20:45 INFO - PID 31321 | RSS: Main: 188870656 18:20:45 INFO - PID 31321 | 18:20:47 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45336/tests/kraken/driver.html?testName=json-parse-financial) 18:20:48 INFO - PID 31321 | RSS: Main: 189337600 18:20:48 INFO - PID 31321 | 18:20:50 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45336/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:20:50 INFO - PID 31321 | RSS: Main: 189440000 18:20:50 INFO - PID 31321 | 18:20:52 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45336/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:20:53 INFO - PID 31321 | RSS: Main: 189112320 18:20:53 INFO - PID 31321 | 18:20:55 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45336/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:20:56 INFO - PID 31321 | RSS: Main: 189546496 18:20:56 INFO - PID 31321 | 18:20:58 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:20:59 INFO - PID 31321 | RSS: Main: 189239296 18:20:59 INFO - PID 31321 | 18:21:02 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:21:03 INFO - PID 31321 | RSS: Main: 189280256 18:21:03 INFO - PID 31321 | 18:21:04 INFO - PID 31321 | Cycle 1(1): loaded http://localhost:45336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45336/tests/kraken/driver.html?testName=ai-astar) 18:21:05 INFO - PID 31321 | RSS: Main: 190738432 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | __start_tp_report 18:21:05 INFO - PID 31321 | _x_x_mozilla_page_load 18:21:05 INFO - PID 31321 | _x_x_mozilla_page_load_details 18:21:05 INFO - PID 31321 | |i|pagename|runs| 18:21:05 INFO - PID 31321 | |0;ai-astar;100;108;109;108;109;109;108;109;112;111 18:21:05 INFO - PID 31321 | |1;audio-beat-detection;148;122;125;175;122;121;121;120;143;121 18:21:05 INFO - PID 31321 | |2;audio-dft;163;164;163;163;164;164;168;170;166;161 18:21:05 INFO - PID 31321 | |3;audio-fft;74;74;74;100;75;74;78;73;96;75 18:21:05 INFO - PID 31321 | |4;audio-oscillator;83;83;109;82;82;82;100;83;82;102 18:21:05 INFO - PID 31321 | |5;imaging-gaussian-blur;114;114;116;117;114;114;114;114;114;115 18:21:05 INFO - PID 31321 | |6;imaging-darkroom;150;151;149;150;151;150;149;151;150;153 18:21:05 INFO - PID 31321 | |7;imaging-desaturate;95;95;95;94;94;95;98;99;96;94 18:21:05 INFO - PID 31321 | |8;json-parse-financial;52;53;56;53;53;54;55;56;56;53 18:21:05 INFO - PID 31321 | |9;json-stringify-tinderbox;58;57;56;59;56;56;56;55;57;55 18:21:05 INFO - PID 31321 | |10;stanford-crypto-aes;84;84;84;85;84;84;84;87;103;84 18:21:05 INFO - PID 31321 | |11;stanford-crypto-ccm;131;139;139;144;134;131;146;133;142;135 18:21:05 INFO - PID 31321 | |12;stanford-crypto-pbkdf2;183;190;188;186;194;187;185;187;179;188 18:21:05 INFO - PID 31321 | |13;stanford-crypto-sha256-iterative;73;75;75;73;73;74;74;74;69;72 18:21:05 INFO - PID 31321 | __end_tp_report 18:21:05 INFO - PID 31321 | __start_cc_report 18:21:05 INFO - PID 31321 | _x_x_mozilla_cycle_collect,995 18:21:05 INFO - PID 31321 | __end_cc_report 18:21:05 INFO - PID 31321 | __startTimestamp1496798465164__endTimestamp 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | ------- Summary: start ------- 18:21:05 INFO - PID 31321 | Number of tests: 14 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:3.20 (2.9%) stddev-sans-first:1.39 18:21:05 INFO - PID 31321 | Values: 100.0 108.0 109.0 108.0 109.0 109.0 108.0 109.0 112.0 111.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:123.50 stddev:18.20 (14.7%) stddev-sans-first:18.34 18:21:05 INFO - PID 31321 | Values: 148.0 122.0 125.0 175.0 122.0 121.0 121.0 120.0 143.0 121.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.67 (1.6%) stddev-sans-first:2.77 18:21:05 INFO - PID 31321 | Values: 163.0 164.0 163.0 163.0 164.0 164.0 168.0 170.0 166.0 161.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#3] audio-fft Cycles:10 Average:79.30 Median:74.50 stddev:9.99 (13.4%) stddev-sans-first:10.41 18:21:05 INFO - PID 31321 | Values: 74.0 74.0 74.0 100.0 75.0 74.0 78.0 73.0 96.0 75.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.00 stddev:10.51 (12.8%) stddev-sans-first:10.93 18:21:05 INFO - PID 31321 | Values: 83.0 83.0 109.0 82.0 82.0 82.0 100.0 83.0 82.0 102.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.12 18:21:05 INFO - PID 31321 | Values: 114.0 114.0 116.0 117.0 114.0 114.0 114.0 114.0 114.0 115.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:1.17 (0.8%) stddev-sans-first:1.24 18:21:05 INFO - PID 31321 | Values: 150.0 151.0 149.0 150.0 151.0 150.0 149.0 151.0 150.0 153.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.72 (1.8%) stddev-sans-first:1.81 18:21:05 INFO - PID 31321 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 98.0 99.0 96.0 94.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:1.52 (2.8%) stddev-sans-first:1.41 18:21:05 INFO - PID 31321 | Values: 52.0 53.0 56.0 53.0 53.0 54.0 55.0 56.0 56.0 53.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.50 stddev:1.27 (2.2%) stddev-sans-first:1.22 18:21:05 INFO - PID 31321 | Values: 58.0 57.0 56.0 59.0 56.0 56.0 56.0 55.0 57.0 55.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:84.00 stddev:5.95 (7.1%) stddev-sans-first:6.25 18:21:05 INFO - PID 31321 | Values: 84.0 84.0 84.0 85.0 84.0 84.0 84.0 87.0 103.0 84.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:139.00 stddev:5.40 (3.9%) stddev-sans-first:5.21 18:21:05 INFO - PID 31321 | Values: 131.0 139.0 139.0 144.0 134.0 131.0 146.0 133.0 142.0 135.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.70 Median:187.50 stddev:4.00 (2.1%) stddev-sans-first:4.01 18:21:05 INFO - PID 31321 | Values: 183.0 190.0 188.0 186.0 194.0 187.0 185.0 187.0 179.0 188.0 18:21:05 INFO - PID 31321 | 18:21:05 INFO - PID 31321 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:74.00 stddev:1.75 (2.4%) stddev-sans-first:1.86 18:21:05 INFO - PID 31321 | Values: 73.0 75.0 75.0 73.0 73.0 74.0 74.0 74.0 69.0 72.0 18:21:05 INFO - PID 31321 | -------- Summary: end -------- 18:21:05 INFO - PID 31321 | 18:21:06 INFO - TEST-INFO | 31321: exit 0 18:21:06 INFO - TEST-OK | kraken | took 91875ms 18:21:06 INFO - SUITE-END | took 1234s 18:21:06 INFO - Completed test suite (00:20:35) 18:21:06 INFO - javascript benchmark 18:21:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7593.452590330416, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.694330566943, 3068.907932762018, 3080.614923134608, 3091.6908309169085, 3104.798188117772, 5826.796062137826, 5849.093390524465, 5874.236349274599, 5894.6168499047535, 5941.13853491244, 5923.466887980081, 5949.8215053548465, 5999.370066143058, 6069.999999999989, 6091.421314975081, 5459.727013649302, 5514.393416724167, 5559.9444005560035, 5602.935442265977, 5618.971905140468, 5644.322681278252, 5657.8585535361535, 5659.952908711881, 5660.830175094754, 5685.459881311269, 5411.134218525057, 5486.039943009957, 5508.476694714036, 5540.86147846303, 5575.581831362644, 5534.4742249486235, 5557.249771280865, 5567.164925261202, 5569.498745112959, 5572.136318870582, 5502.697351645658, 5513.173024046425, 5519.282493275889, 5527.281453411031, 5533.3083364579425, 5841.766329346821, 5959.523238140939, 5980.491658209057, 5989.3112292086535, 5995.400459954013, 6291.8741625167695, 6352.904706429407, 6401.135846660734, 6405.359464053604, 6440.5491615586925, 6510.08858759774, 6514.120593719835, 6524.804255872332, 6529.2164940207, 6541.901871471931, 6032.672811981357, 6050.515958723292, 6068.484178844759, 6078.665673387962, 6081.391860813927, 6449.226092868886, 6530.118434011348, 6545.0, 6619.86760264792, 6646.468282537386, 6167.475764560063, 6172.475339596184, 6249.781257656051, 6352.047192921099, 6362.427381535592, 6449.806505804833, 6461.903071453932, 6462.063000864942, 6470.191226096738, 6506.642134682544, 6455.0, 6483.546151769331, 6487.7080531376205, 6495.350464953562, 6499.577527460794, 6288.119663247149, 6316.968415157987, 6383.010633351838, 6391.648459334781, 6452.354764523604, 5236.083685355047, 5248.107821670325, 5255.0, 5276.657017293864, 5296.523312901781, 4466.330050492387, 4468.374427580141, 4481.148581769454, 4493.1013797240685, 4500.819967201275, 5507.944920550824, 5566.944330556643, 5618.0449323615085, 5679.091345384719, 5735.369109397963, 6486.44865186455, 6536.986767051115, 6538.509611779135, 6544.640044797487, 6555.541112122106, 5624.634398764068, 5680.829575112753, 5684.431556844283, 5700.657960522382, 5730.656160630376, 5440.102383106743, 5575.804846830341, 5597.888042239214, 5598.0, 5601.859953501195, 6164.815055548341, 6191.504679625619, 6305.1172835803945, 6308.589941653778, 6316.431521163117, 6518.054882041983, 6519.8044058678315, 6522.086907832812, 6526.24948130971, 6537.411632953057, 6260.593061450991, 6305.337939516468, 6313.747450101944, 6317.810465686037, 6334.144890439732, 6180.907286390618, 6219.191505104308, 6305.653189074645, 6372.936270637234, 6386.808395748135, 6545.574537655038, 6549.24683661385, 6553.0, 6553.606783593, 6584.144061272004, 5960.403959604005, 6066.908996364969, 6287.371262873676, 6292.433680968552, 6313.494920406265, 6188.133661287334, 6270.717817698306, 6288.465480434214, 6300.0234963580715, 6321.178246828067, 6161.6919154041225, 6204.100405441095, 6212.81361559154, 6216.347283535345, 6234.064890266496, 6173.382661733791, 6241.001439769615, 6347.841303967438, 6361.427471527585, 6378.585391949508, 6122.755089796537, 6183.165272688309, 6188.319284878749, 6192.133101365903, 6205.286392064971], "value": 5890.021918480319, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.6629750314855, 789.6959670526848, 813.9674413023478, 1127.7349822791643, 1142.8400023996637, 35735.28529429413, 36593.0, 36613.0, 36682.633173668255, 36698.816505917435, 38828.611713882856, 39107.0, 39407.80296098516, 39415.60584394155, 39416.0, 7281.927180728205, 7366.521176123548, 7398.334149926505, 7414.703411863546, 7503.849923001537, 7315.451341149408, 7458.850822983537, 7462.664180111881, 7494.025776649028, 7512.0, 7496.0, 7548.773536793905, 7569.318761311481, 7590.962045189766, 7591.658375373121, 7439.404847612205, 7504.024476817979, 7510.061242344707, 7529.548227106391, 7536.321731044178, 7361.631918404112, 7375.668094935741, 7416.295451932057, 7443.032405787213, 7448.2179371165785, 35832.64167358345, 36029.639703602894, 36036.0, 36215.09462263438, 36417.27165456703, 3363.2768954674616, 3403.7447191460737, 3406.8296585170892, 3411.4200585900207, 3414.573178352706, 28457.857710711312, 28582.0, 28620.856895715595, 28627.284317892012, 28692.856535717186, 3179.300553878143, 3335.69978701918, 3355.781874178195, 3375.0718552398043, 3385.0521853880705, 129071.0, 132974.0, 134193.0, 167429.0, 167594.0, 38309.23381532354, 38686.0, 38769.61230387716, 38771.0, 38842.805785970886, 40144.799276004014, 40639.39040914389, 40696.0, 45113.77443112763, 46628.0, 15311.923440382727, 15499.690006199813, 15506.9224653876, 15510.30203640839, 15515.0, 12545.874541254652, 12631.305278209788, 12638.2417054977, 12676.23942563449, 12709.364531773374, 14601.0, 14665.193414362098, 14685.41258349654, 14731.779023314659, 14766.114033158045, 5776.797812076557, 5915.024021036566, 5990.400959904062, 6020.397960204032, 6030.517558595302, 946.8721722567503, 958.8417911044739, 972.3679608254549, 1003.5634498992962, 1027.635189507729, 21692.45768855791, 23304.368694191246, 23675.881620592132, 23854.88072559626, 24186.758132418803, 1065.9040686338267, 1069.2248120112856, 1097.2100087936833, 1102.4928532874808, 1106.0874778307927, 11950.88049119515, 15968.201589920458, 16211.183525932493, 16251.756223656655, 16263.837361626469, 198270.0, 200819.0, 201309.0, 202355.0, 202869.0, 53294.73352633289, 53363.19955200675, 53474.73262633662, 53574.46425535695, 53699.46300536945, 1398.4615922869566, 1435.4258296681203, 1435.8205224346957, 1444.9638759030897, 1446.2768615692155, 25928.8703556481, 27851.860740696167, 27968.860155699906, 28188.29529261703, 28337.574936376383, 35362.11594710153, 35578.28843423065, 35602.287954241285, 35639.46540801838, 35641.82179089088, 181067.0, 182385.0, 182400.0, 182597.0, 182610.0869495644, 28615.570766438937, 28787.568186477638, 28881.133565993056, 28972.102789721703, 29090.418191636472, 34012.659873400946, 34736.652633474354, 34797.0, 34818.47772283469, 35005.9498215054, 25127.87436062808, 26710.0, 27104.1868743938, 30334.84832575823, 32123.0, 28547.42905141844, 29407.705922940495, 29527.557086643286, 30346.241343965696, 31101.377972439972, 34263.48604770881, 34311.65688343085, 34362.82818585891, 34744.82627586846, 35212.0, 28416.289592760346, 29260.56109158407, 29923.70076299209, 30490.237744056576, 31023.84488077545, 21670.24154154597, 24181.0, 24287.51424971526, 24489.265322040366, 24554.140605078737], "value": 16164.508495901104, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.3215203773491, 403.1714826032502, 406.7539138821014, 412.2065024827208, 421.191312679655, 14539.92730036351, 15123.31945062472, 19764.0, 20393.592128157426, 20456.69314960277, 21289.361319160413, 22051.889740551276, 22186.556268874654, 22212.1115155394, 22218.00018999145, 5815.709214539267, 5890.469857712805, 5920.763169473216, 5945.672987985659, 5954.434328738763, 5807.5644326675665, 5915.171875937351, 5916.852078698024, 5918.023526118185, 5926.4073592640825, 5599.188117722928, 5827.592068555203, 5845.941540584604, 5852.824415267549, 5863.648181109126, 5817.505512031483, 5834.708264586754, 5840.970795146019, 5844.620099693507, 5847.707614619252, 5219.739013049332, 5238.92141617876, 5247.737613119329, 5279.076161671692, 5280.287161233223, 24456.510869782505, 24615.63076553853, 24851.13021044255, 24872.12947546827, 24898.0, 1790.8656850736247, 1821.9796913728221, 1823.4985379020743, 1826.1873466307497, 1832.1846778183713, 15540.533783986499, 16365.42721004771, 16414.6717065658, 16487.093209873452, 16518.174091295386, 2149.4948687058527, 2166.42589713726, 2211.579799838026, 2213.8118259947923, 2216.0692509146197, 114070.42964785123, 118291.0, 118957.0, 119706.0, 119853.0, 10997.230193886351, 11454.48454819535, 11462.0, 11475.131726009879, 11643.0, 16446.75329870053, 16446.75329870053, 16465.753013704805, 16508.42220522276, 16544.83455165457, 8554.957225213959, 8573.657053717907, 8589.484630922165, 8630.093840146694, 8738.86891696625, 8421.663133474593, 8466.661333546712, 8492.872606910902, 8572.057073721886, 8615.353848461391, 7415.814604634819, 7490.887636685454, 7522.699092036257, 7538.962305188439, 7678.961605191938, 1971.6488435712508, 2063.9896800515903, 2079.438551591092, 2086.0925497408675, 2187.7702841201444, 913.7715571107224, 914.3919293669635, 916.7799728065216, 944.5560586524323, 976.3995142987012, 17267.568310792332, 17328.48014559565, 17813.0, 18076.548086297684, 18365.7245141323, 912.3431129586687, 933.780561568031, 951.5955718819474, 957.1146689312358, 983.0759086458706, 9388.028921410265, 9528.333016688764, 9699.321047526606, 9873.506324683736, 10343.120834728981, 405357.0, 411640.0, 412399.0, 416042.0, 419644.0, 93138.53430732939, 95723.0, 97004.51497742467, 97241.0, 97587.51206243923, 1097.8078836203633, 1119.972000699989, 1131.2759833706434, 1134.7049767060623, 1148.6152139033518, 15225.847741522442, 15636.92181539085, 15869.285882135562, 16261.0, 16833.0, 44494.0, 44929.32606010978, 45691.54308456873, 46095.0, 47457.28814067723, 58213.41786582249, 58731.0, 59166.70416647889, 59271.40728592659, 59437.0, 9807.362521436084, 10014.599416023277, 10166.186705063725, 10174.13519850821, 10180.236482263712, 16599.0, 16651.91674041622, 16887.240074196445, 17934.0, 18424.907875460536, 14066.648333791327, 14167.079139855876, 14302.356393962089, 15231.314590843216, 15321.540353789404, 13377.53178638743, 13516.93241533786, 13577.660558486117, 13833.515826946008, 13959.651008724863, 14249.857501424853, 14569.854301457273, 14654.047486913316, 14677.045992010486, 14782.852171478578, 16292.918535407247, 16653.0, 16777.41279055276, 16821.831781682515, 16826.990380577205, 13693.520726774914, 13793.517226897411, 14219.786703199667, 14443.78334324965, 14534.0], "value": 10104.724886606291, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.1380102933094, 1378.2695171559064, 1381.4336122189904, 1391.6868704541473, 1393.8745512903836, 10407.635732749355, 10749.301295415802, 10785.83821242682, 10929.180311476652, 11283.0, 10972.341659500436, 11297.774044519105, 11314.094872410207, 11317.264377815436, 11333.263337883032, 2321.779430954057, 2355.093289083698, 2359.7876191142796, 2364.3498038039506, 2370.3600027992434, 2289.919852805152, 2332.1371092695726, 2333.556624241397, 2335.4469277930243, 2340.438294809242, 2252.932412027642, 2273.533925545259, 2289.1072481732053, 2301.8043466305385, 2302.804261637763, 2155.374941267031, 2228.832837537183, 2229.030371788277, 2232.5088480534337, 2234.6312858378346, 2142.6250406178856, 2218.8779617121054, 2245.124401483423, 2278.2254033628647, 2294.128231272123, 10914.126869850394, 10983.176261780398, 10989.340639561571, 11001.394923279217, 11002.064824489928, 5786.421357864222, 5942.435468630473, 5977.133315669247, 6010.8497287567725, 6018.969905150446, 3426.674465925733, 3587.515685382492, 3619.6199399062984, 3626.2928728897878, 3651.361011822947, 1201.1831954271092, 1214.4474264209853, 1219.3842109734617, 1263.5830176041884, 1266.8163116348078, 15809.130497822614, 15933.521994340072, 15955.521334359988, 15995.200239988071, 16030.438934637348, 4790.353302304214, 4831.589314908202, 4840.056189043103, 4886.755662216875, 4899.853004409873, 11742.119341049456, 11794.174407791372, 11834.17160798753, 11840.585579504675, 11842.76314473723, 5868.383819698955, 6099.878002440015, 6133.355997620275, 6140.6929653517145, 6142.109394137825, 5641.153826925912, 5722.399148089474, 5743.4543718346695, 5769.336526299529, 5784.4504772046585, 4050.331695270306, 4101.651359634405, 4143.772092534879, 4174.0, 4204.474440694913, 1147.5008371358485, 1148.534843388429, 1164.7262893220086, 1167.2121318110242, 1179.6932797472718, 813.6989313953875, 832.4672209785742, 835.7325655790089, 842.2588122452325, 864.9308055355557, 5463.644863083887, 5764.962346413017, 5915.260592425947, 5982.641041537521, 6006.459418652343, 594.6164723753155, 598.3119412675458, 606.5572132343414, 614.6803662095685, 614.7786796753165, 3799.5820459749407, 3813.2945405100145, 3960.663343615767, 4015.8393664253686, 4165.937510937339, 13577.0, 14025.0, 14141.717165656835, 14146.71706565863, 14179.220142892034, 13741.381637826322, 13961.301934903215, 13961.952853536026, 13963.860361396459, 13969.441222351195, 8211.8357632847, 8613.440126391764, 8617.95691021541, 8630.913690863137, 8633.136686331316, 6507.674616269073, 6522.34776522344, 6640.269570347355, 6852.6231057292325, 7116.074910261633, 12283.201591896499, 12626.747465050465, 12737.363131843185, 12756.425960831599, 12969.157004794659, 13120.475180992653, 13165.275909825052, 13279.80080298777, 13285.667858303234, 13329.0, 8611.913880861111, 8735.868961965703, 9035.819283614423, 9129.406588571721, 9138.360314777901, 10701.946490267499, 10846.566137354417, 10846.728831779268, 10883.945580272048, 10893.237473376788, 8770.517621530622, 8792.47245165292, 9060.275177985613, 9146.131117543822, 9197.908020919705, 8687.261582765283, 8724.607392667218, 8764.0, 8780.341474389574, 9017.05320941318, 7470.0, 7476.140243872024, 7530.548167109991, 7541.849163016599, 7573.242675732383, 5612.382637909745, 5669.376368599534, 5793.420657934173, 5983.34183239852, 6013.188219590475, 5306.381553626181, 5535.972320138535, 5595.300587426572, 5707.429257074426, 5799.217105690678], "value": 5036.109487201806, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.35312028911716, 398.2711637703004, 401.6124439915481, 408.7200267816546, 409.7091065343606, 6102.450779429851, 6322.494200463963, 6324.905126423101, 6332.810015699531, 6406.3233839297345, 6040.365761595035, 6085.665288409146, 6115.541334399915, 6119.755209791603, 6160.1683772690785, 4750.311204875291, 4760.262159365304, 4762.761861906908, 4764.690295130806, 4776.331313616097, 4773.928391074137, 4783.091212669582, 4792.329073929653, 4797.304390863323, 4800.183968725308, 4718.90562188756, 4741.478437371887, 4748.121597504455, 4758.500357462469, 4759.785809638574, 4734.171519984006, 4738.691985020962, 4740.739259340735, 4744.810207591692, 4745.620350371962, 4121.794839760743, 4135.483064616923, 4149.190907772985, 4152.522459917088, 4160.604742549453, 6102.511799056109, 6114.480269177081, 6120.632762034292, 6127.958247098004, 6147.538934579879, 5436.401995780461, 5444.972775136099, 5451.3458384993655, 5454.10007348787, 5455.5908306876745, 6561.7375304987745, 6564.704588293538, 6566.474682025427, 6580.88125018748, 6584.76953306632, 4535.750533720644, 4542.955120322311, 4545.863624091249, 4552.613027892633, 4557.589816916494, 6490.545661803676, 6851.417629501499, 6867.381935625767, 6897.896531551981, 6977.686004129776, 4554.24854898938, 4572.908541829145, 4589.288660257599, 4592.448906131219, 4598.839040633628, 4559.247724125548, 4608.953910460919, 4613.446386433649, 4632.826513838032, 4635.420572428447, 5172.715500647425, 5311.575073994149, 5351.946480535223, 5378.784848606012, 5414.945850541523, 6605.900911486331, 6614.206295244601, 6623.370779775913, 6629.668516574152, 6640.933590664032, 1601.54356008537, 1613.4191690991233, 1620.9270582823801, 1626.4795265515158, 1628.364937674308, 1051.363924825485, 1083.664064140119, 1085.9565617375374, 1093.6609651008214, 1097.3799803111217, 5798.739056742456, 5844.415558444207, 5849.1226316052935, 5863.882722345615, 5877.147813567009, 6798.218204906499, 6806.625635589991, 6810.31896810315, 6818.147731533559, 6827.146606674166, 5738.598298119092, 5779.757352169219, 5791.594588378857, 5825.38833422493, 5861.238039054895, 3608.512850765113, 3608.6030536640947, 3617.2584620152807, 3639.1993761372455, 3642.9799656096334, 6553.967230163818, 6574.934250657528, 6588.143541339691, 6598.7030583623855, 6600.669966501751, 6970.686319115652, 6977.441804655616, 6995.580265184003, 7036.683349249296, 7046.260142684944, 6588.4070433660245, 6622.602643841385, 6629.5359324846795, 6633.568818026813, 6649.667516624149, 6785.287544807921, 6816.7614133505085, 6838.692258848463, 6860.382565568923, 6870.965645171742, 6422.293547709842, 6766.391024807791, 6797.626130562867, 6800.761973330909, 6820.795376138723, 6552.08270842092, 6594.175728033996, 6610.471162306908, 6622.701978410887, 6623.138991931018, 4625.653076019379, 4637.62898968075, 4637.721736695809, 4638.628909687284, 4647.419072615923, 6636.701348439428, 6766.695498702472, 6811.761588344384, 6821.624810635462, 6869.175698916162, 6546.9883853427955, 6653.966730166512, 6666.400023997863, 6668.899966500603, 6681.716928547906, 6578.177727784027, 6624.370684784938, 6636.601803891782, 6657.933420665731, 6678.799636010927, 6375.5654977629665, 6469.385408386196, 6488.318726533646, 6490.675466226764, 6544.9672751635935, 6589.275179730322, 6606.174228221473, 6654.73381064752, 6661.866762664817, 6680.766173183915, 6411.326810684997, 6437.549371543947, 6466.353364663496, 6480.7686539557335, 6480.8703825922275], "value": 4928.938255343973, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.8288859339539, 848.7793173774819, 854.8375808596367, 860.4708104515721, 866.2333834556417, 15130.470433534829, 15899.443519476821, 15923.12422816746, 18639.813601863978, 19863.900680496612, 18085.0, 18213.0, 18448.815511844878, 18470.53823654406, 18488.168032438538, 955.4410669758182, 980.8871979722352, 983.2134292565954, 986.8865080515725, 989.0, 931.0549791961165, 990.2474119669031, 999.2755252441958, 1001.9098281154695, 1016.9338992965434, 1060.512164404371, 1062.0812996757827, 1064.6912395405323, 1066.1204506282347, 1067.4555976451988, 1054.620336678795, 1059.464970190053, 1060.9045185933264, 1061.0927656853357, 1063.8404239364118, 772.8763397856316, 774.1716363491067, 775.5463054113351, 776.3245976000859, 777.315961953483, 16877.324907003705, 17205.397811076677, 17423.39018134372, 17447.21487533064, 17453.301867925267, 18663.53341166468, 18830.62338753231, 19239.51901202467, 19287.710684339745, 19296.517587060294, 15339.309731062129, 15511.922440387838, 15531.0, 15556.922215388851, 15599.220038998119, 3339.365520551112, 3350.279689866666, 3394.2023624448234, 3405.744569157323, 3413.061408112764, 80134.0, 81764.59117704433, 99075.50462247715, 100152.0, 101008.0, 14455.13269203851, 14957.700845983238, 14960.551183464513, 15043.247837608076, 15097.39610415593, 27243.182704518895, 27369.45261094767, 27451.862740686167, 27818.72181278202, 27862.442751144863, 7749.922500775033, 8105.432619716563, 8130.065042520186, 8172.468789528662, 8219.630116644765, 3630.3828349180703, 3695.2055308108884, 3708.2212735325343, 3713.1459764254373, 3719.795411252407, 4236.661067114624, 4312.072904325522, 4339.0, 4343.543927887589, 4361.934570981438, 870.0690261420347, 876.4522173641474, 877.5173654490005, 887.7824932891483, 890.238845786843, 636.9076483909807, 665.70043480434, 679.4496457869142, 694.1150033707064, 698.7624207769383, 9551.0, 10493.842592361121, 10522.105621022145, 11048.834267485994, 12165.270083794823, 674.1236392689484, 690.6236101324689, 693.715576613586, 699.1679900917892, 705.3651713457929, 4866.0, 4907.386576677915, 5009.44896061433, 5046.520580544842, 5172.431032586413, 91363.0, 91484.0, 91969.54015229881, 92287.5385623081, 93515.0, 82188.17811821925, 82609.58695206486, 82613.17386826174, 82845.0, 83479.0, 68867.0, 73508.63245683844, 73740.0, 73957.78126656209, 74166.62916685382, 9659.613615455302, 9773.804523909625, 9783.36408133469, 10114.797704046025, 10271.537780799732, 33333.66666333305, 33342.16644583905, 33466.83266583652, 33699.0, 34023.65976340205, 40479.392809107296, 40644.3903341456, 40963.7951810239, 41275.793621031706, 41840.0, 14666.77999829982, 14757.704845903236, 14849.480268190562, 15032.6993460128, 15140.848591514385, 16515.17424128813, 16659.75010374821, 16743.0, 16751.581210469834, 17055.0, 14930.850691492946, 15149.469768558047, 15192.164430955962, 15358.769618455508, 15676.76484852751, 15197.6200594986, 15321.310541025903, 15437.459688910834, 15501.379944802082, 15644.608884777972, 14939.850601493847, 14974.47589334368, 15394.692106158038, 15572.14353210539, 15799.763003554726, 11197.44012799373, 11301.886981130083, 11556.94221528887, 11633.41832908368, 11740.647780566254, 10720.892791072301, 10803.837942430713, 11048.613298534512, 11068.28056176346, 11407.771844563229], "value": 8027.0210229787845, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 109.0, 108.0, 109.0, 109.0, 108.0, 109.0, 112.0, 111.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 125.0, 175.0, 122.0, 121.0, 121.0, 120.0, 143.0, 121.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 164.0, 164.0, 168.0, 170.0, 166.0, 161.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 100.0, 75.0, 74.0, 78.0, 73.0, 96.0, 75.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 109.0, 82.0, 82.0, 82.0, 100.0, 83.0, 82.0, 102.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 117.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 149.0, 150.0, 151.0, 150.0, 149.0, 151.0, 150.0, 153.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 98.0, 99.0, 96.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 56.0, 53.0, 53.0, 54.0, 55.0, 56.0, 56.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 59.0, 56.0, 56.0, 56.0, 55.0, 57.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 87.0, 103.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 139.0, 139.0, 144.0, 134.0, 131.0, 146.0, 133.0, 142.0, 135.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 190.0, 188.0, 186.0, 194.0, 187.0, 185.0, 187.0, 179.0, 188.0], "value": 186.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 73.0, 73.0, 74.0, 74.0, 74.0, 69.0, 72.0], "value": 73.2, "unit": "score"}]}]} 18:21:06 INFO - Return code: 0 18:21:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:21:07 INFO - # TBPL SUCCESS # 18:21:07 INFO - Running post-action listener: _resource_record_post_action 18:21:07 INFO - [mozharness: 2017-06-07 01:21:07.059732Z] Finished run-tests step (success) 18:21:07 INFO - Running post-run listener: _resource_record_post_run 18:21:07 INFO - Total resource usage - Wall time: 1253s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433754112; Read time: 8; Write time: 342076 18:21:07 INFO - TinderboxPrint: CPU usage
12.6% 18:21:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:21:07 INFO - TinderboxPrint: I/O write bytes / time
433,754,112 / 342,076 18:21:07 INFO - TinderboxPrint: CPU idle
8,735.2 (87.3%) 18:21:07 INFO - TinderboxPrint: CPU user
1,210.8 (12.1%) 18:21:07 INFO - TinderboxPrint: Swap in / out
0 / 0 18:21:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 104218624; Read time: 0; Write time: 75476 18:21:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:21:07 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 329535488; Read time: 8; Write time: 266600 18:21:07 INFO - Running post-run listener: _upload_blobber_files 18:21:07 INFO - Blob upload gear active. 18:21:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:21:07 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:21:07 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:21:07 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:21:08 INFO - (blobuploader) - INFO - Open directory for files ... 18:21:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:21:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:21:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:09 INFO - (blobuploader) - INFO - Done attempting. 18:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:21:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:10 INFO - (blobuploader) - INFO - Done attempting. 18:21:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:21:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:21:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:11 INFO - (blobuploader) - INFO - Done attempting. 18:21:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:21:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:21:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:14 INFO - (blobuploader) - INFO - Done attempting. 18:21:14 INFO - (blobuploader) - INFO - Iteration through files over. 18:21:14 INFO - Return code: 0 18:21:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:21:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:21:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd9694b0af1ad892989f21484c102f35e7d8f90fd195339b8f103f7cfb001d29449a0d0e3ff7634a056e026d50511e74cfb1974a85342aea888f272e1a93e8fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a0ee118cf2d5b70f708ac1a74cefd84073d84d41e03aa922fb918e07c5484d872791938639beb5792dad2932c5c0bfdb0d7a58b3ab042299ad204ffb95de341", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11064d9ffa9ab0775d397ff678ceedbae99b72b5ee290b1f0b21aa4ba3e112ac7192322a91b8956de2b729298ba7edd06eb8cad139e52a383ce63bc0fbe88085", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22e441a2b2616459e8339a3714d6042ed7e09fc67ab74dd1c9d42d004b6f0a89035c812ef41e6a49849504f1f6e8269b3a8e693e7f1d681e8f31ab7d5f76fda8"} 18:21:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:21:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:21:14 INFO - Contents: 18:21:14 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd9694b0af1ad892989f21484c102f35e7d8f90fd195339b8f103f7cfb001d29449a0d0e3ff7634a056e026d50511e74cfb1974a85342aea888f272e1a93e8fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a0ee118cf2d5b70f708ac1a74cefd84073d84d41e03aa922fb918e07c5484d872791938639beb5792dad2932c5c0bfdb0d7a58b3ab042299ad204ffb95de341", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11064d9ffa9ab0775d397ff678ceedbae99b72b5ee290b1f0b21aa4ba3e112ac7192322a91b8956de2b729298ba7edd06eb8cad139e52a383ce63bc0fbe88085", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22e441a2b2616459e8339a3714d6042ed7e09fc67ab74dd1c9d42d004b6f0a89035c812ef41e6a49849504f1f6e8269b3a8e693e7f1d681e8f31ab7d5f76fda8"} 18:21:14 INFO - Running post-run listener: copy_logs_to_upload_dir 18:21:14 INFO - Copying logs to upload dir... 18:21:14 INFO - mkdir: /builds/slave/test/build/upload/logs 18:21:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.779980 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-06 18:21:14.039834) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 18:21:14.043794) ========= 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-1496789410.485969-1762224138 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/dd9694b0af1ad892989f21484c102f35e7d8f90fd195339b8f103f7cfb001d29449a0d0e3ff7634a056e026d50511e74cfb1974a85342aea888f272e1a93e8fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a0ee118cf2d5b70f708ac1a74cefd84073d84d41e03aa922fb918e07c5484d872791938639beb5792dad2932c5c0bfdb0d7a58b3ab042299ad204ffb95de341", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11064d9ffa9ab0775d397ff678ceedbae99b72b5ee290b1f0b21aa4ba3e112ac7192322a91b8956de2b729298ba7edd06eb8cad139e52a383ce63bc0fbe88085", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22e441a2b2616459e8339a3714d6042ed7e09fc67ab74dd1c9d42d004b6f0a89035c812ef41e6a49849504f1f6e8269b3a8e693e7f1d681e8f31ab7d5f76fda8"} build_url:https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/NRSVz81RQ9iSzTtcJ00cnw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd9694b0af1ad892989f21484c102f35e7d8f90fd195339b8f103f7cfb001d29449a0d0e3ff7634a056e026d50511e74cfb1974a85342aea888f272e1a93e8fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a0ee118cf2d5b70f708ac1a74cefd84073d84d41e03aa922fb918e07c5484d872791938639beb5792dad2932c5c0bfdb0d7a58b3ab042299ad204ffb95de341", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11064d9ffa9ab0775d397ff678ceedbae99b72b5ee290b1f0b21aa4ba3e112ac7192322a91b8956de2b729298ba7edd06eb8cad139e52a383ce63bc0fbe88085", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22e441a2b2616459e8339a3714d6042ed7e09fc67ab74dd1c9d42d004b6f0a89035c812ef41e6a49849504f1f6e8269b3a8e693e7f1d681e8f31ab7d5f76fda8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 18:21:14.073472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 18:21:14.073802) ========= 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-1496789410.485969-1762224138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004325 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 18:21:14.157842) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 18:21:14.158184) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 18:21:14.158508) ========= ========= Total master_lag: 0.17 =========