builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1496894219.33 results: success (0) revision: 7efda263a842e60cd0cc00b3c4a7058c65590702 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-07 20:56:59.328536) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-07 20:56:59.328973) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-07 20:56:59.329258) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-07 20:56:59.345109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 20:56:59.345410) ========= 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=eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-07 20:57:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.4M=0s 2017-06-07 20:57:01 (54.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091187 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 20:56:59.449535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 20:56:59.449824) ========= 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=eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020639 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 20:56:59.502260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 20:56:59.502563) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7efda263a842e60cd0cc00b3c4a7058c65590702 --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 7efda263a842e60cd0cc00b3c4a7058c65590702 --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=eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-07 20:57:01,784 truncating revision to first 12 chars 2017-06-07 20:57:01,784 Setting DEBUG logging. 2017-06-07 20:57:01,784 attempt 1/10 2017-06-07 20:57:01,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7efda263a842?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-07 20:57:02,277 unpacking tar archive at: mozilla-central-7efda263a842/testing/mozharness/ program finished with exit code 0 elapsedTime=0.800548 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 20:57:00.316909) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-07 20:57:00.317224) ========= script_repo_revision: 7efda263a842e60cd0cc00b3c4a7058c65590702 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-07 20:57:00.317607) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-07 20:57:00.317870) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-07 20:57:00.330329) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2017-06-07 20:57:00.330605) ========= /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=eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:57:02 INFO - MultiFileLogger online at 20170607 20:57:02 in /builds/slave/test 20:57:02 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 20:57:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:57:02 INFO - {'append_to_log': False, 20:57:02 INFO - 'base_work_dir': '/builds/slave/test', 20:57:02 INFO - 'blob_upload_branch': 'Firefox', 20:57:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:57:02 INFO - 'branch': 'Firefox', 20:57:02 INFO - 'buildbot_json_path': 'buildprops.json', 20:57:02 INFO - 'config_files': ('talos/linux_config.py',), 20:57:02 INFO - 'default_actions': ('clobber', 20:57:02 INFO - 'read-buildbot-config', 20:57:02 INFO - 'download-and-extract', 20:57:02 INFO - 'populate-webroot', 20:57:02 INFO - 'create-virtualenv', 20:57:02 INFO - 'install', 20:57:02 INFO - 'setup-mitmproxy', 20:57:02 INFO - 'run-tests'), 20:57:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:57:02 INFO - 'download_minidump_stackwalk': True, 20:57:02 INFO - 'download_symbols': 'ondemand', 20:57:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:57:02 INFO - 'tooltool.py': '/tools/tooltool.py', 20:57:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:57:02 INFO - '/tools/misc-python/virtualenv.py')}, 20:57:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:57:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:57:02 INFO - 'gecko_profile': False, 20:57:02 INFO - 'gecko_profile_interval': 0, 20:57:02 INFO - 'installer_path': 'installer.exe', 20:57:02 INFO - 'log_level': 'info', 20:57:02 INFO - 'log_name': 'talos', 20:57:02 INFO - 'log_to_console': True, 20:57:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:57:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:57:02 INFO - 'opt_config_files': (), 20:57:02 INFO - 'pip_index': False, 20:57:02 INFO - 'suite': 'dromaeojs-e10s', 20:57:02 INFO - 'system_bits': '32', 20:57:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:57:02 INFO - 'title': 'talos-linux64-ix-010', 20:57:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:57:02 INFO - 'use_talos_json': True, 20:57:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:57:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:57:02 INFO - 'work_dir': 'build'} 20:57:02 INFO - [mozharness: 2017-06-08 03:57:02.712186Z] Running clobber step. 20:57:02 INFO - Running pre-action listener: _resource_record_pre_action 20:57:02 INFO - Running main action method: clobber 20:57:02 INFO - rmtree: /builds/slave/test/build 20:57:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:57:03 INFO - Running post-action listener: _resource_record_post_action 20:57:03 INFO - [mozharness: 2017-06-08 03:57:03.744913Z] Finished clobber step (success) 20:57:03 INFO - [mozharness: 2017-06-08 03:57:03.745015Z] Running read-buildbot-config step. 20:57:03 INFO - Running pre-action listener: _resource_record_pre_action 20:57:03 INFO - Running main action method: read_buildbot_config 20:57:03 INFO - Using buildbot properties: 20:57:03 INFO - { 20:57:03 INFO - "project": "", 20:57:03 INFO - "product": "firefox", 20:57:03 INFO - "who": "ryanvm@gmail.com", 20:57:03 INFO - "installer_path": "public/build/target.tar.bz2", 20:57:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 20:57:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 20:57:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 20:57:03 INFO - "stage_platform": "linux64-pgo", 20:57:03 INFO - "basedir": "/builds/slave/test", 20:57:03 INFO - "buildnumber": 0, 20:57:03 INFO - "platform": "ubuntu64_hw", 20:57:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:57:03 INFO - "slavebuilddir": "test", 20:57:03 INFO - "taskId": "N08r7s8zTt2RdzxGMp-I_A", 20:57:03 INFO - "branch": "mozilla-central", 20:57:03 INFO - "script_repo_revision": "production", 20:57:03 INFO - "revision": "7efda263a842e60cd0cc00b3c4a7058c65590702", 20:57:03 INFO - "slavename": "talos-linux64-ix-010", 20:57:03 INFO - "repo_path": "mozilla-central" 20:57:03 INFO - } 20:57:03 INFO - Finding installer, test and symbols from parent task. 20:57:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N08r7s8zTt2RdzxGMp-I_A'}, attempt #1 20:57:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N08r7s8zTt2RdzxGMp-I_A'}, attempt #1 20:57:04 INFO - Task dependencies: RhJ5SRXgQxylQauR8wwmQA 20:57:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA'}, attempt #1 20:57:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.tar.bz2 20:57:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/test_packages.json 20:57:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.crashreporter-symbols.zip 20:57:05 INFO - Running post-action listener: _resource_record_post_action 20:57:05 INFO - [mozharness: 2017-06-08 03:57:05.115667Z] Finished read-buildbot-config step (success) 20:57:05 INFO - [mozharness: 2017-06-08 03:57:05.115888Z] Running download-and-extract step. 20:57:05 INFO - Running pre-action listener: _resource_record_pre_action 20:57:05 INFO - Running main action method: download_and_extract 20:57:05 INFO - mkdir: /builds/slave/test/build/tests 20:57: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')]} 20:57:05 INFO - trying https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.test_packages.json 20:57:05 INFO - Downloading https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:57:05 INFO - Downloaded 989 bytes. 20:57:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:57:05 INFO - Using the following test package requirements: 20:57:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:57:05 INFO - u'common': [u'target.common.tests.zip'], 20:57:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:57:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:57:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:57:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:57:05 INFO - u'mozbase': [u'target.common.tests.zip'], 20:57:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:57:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:57:05 INFO - u'web-platform': [u'target.common.tests.zip', 20:57:05 INFO - u'target.web-platform.tests.tar.gz'], 20:57:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:57:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:57:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.common.tests.zip 20:57:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:57:05 INFO - Fetch https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.common.tests.zip into memory 20:57:06 INFO - Content-Length response header: 65732756 20:57:06 INFO - Bytes received: 65732756 20:57:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:57:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.common.tests.zip 20:57:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:57:17 INFO - Fetch https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.common.tests.zip into memory 20:57:19 INFO - Content-Length response header: 65732756 20:57:19 INFO - Bytes received: 65732756 20:57:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.talos.tests.zip 20:57:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:57:31 INFO - Fetch https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.talos.tests.zip into memory 20:57:31 INFO - Content-Length response header: 14447563 20:57:31 INFO - Bytes received: 14447563 20:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:32 INFO - trying https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.tar.bz2 20:57:32 INFO - Downloading https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:57:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:57:33 INFO - Downloaded 59819196 bytes. 20:57:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.tar.bz2 20:57:33 INFO - mkdir: /builds/slave/test/properties 20:57:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:57:33 INFO - Writing to file /builds/slave/test/properties/build_url 20:57:33 INFO - Contents: 20:57:33 INFO - build_url:https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.tar.bz2 20:57:33 INFO - Running post-action listener: _resource_record_post_action 20:57:33 INFO - Running post-action listener: set_extra_try_arguments 20:57:33 INFO - [mozharness: 2017-06-08 03:57:33.154435Z] Finished download-and-extract step (success) 20:57:33 INFO - [mozharness: 2017-06-08 03:57:33.154531Z] Running populate-webroot step. 20:57:33 INFO - Running pre-action listener: _resource_record_pre_action 20:57:33 INFO - Running main action method: populate_webroot 20:57:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:57:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:57:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:57:33 INFO - '--tppagecycles', 20:57:33 INFO - '7'], 20:57:33 INFO - 'tests': ['tsvgm']}}, 20:57:33 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:57:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:57:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:57:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:57:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:57:33 INFO - 'talos_options': ['--disable-e10s'], 20:57:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:57:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:57:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:57:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:57:33 INFO - 'talos_options': ['--disable-e10s'], 20:57:33 INFO - 'tests': ['damp', 'tps']}, 20:57:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:57:33 INFO - 'tests': ['damp', 'tps']}, 20:57:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:57:33 INFO - 'tests': ['dromaeo_dom']}, 20:57:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:57:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:57:33 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 20:57:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:57:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:57:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:57:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:57:33 INFO - 'tests': ['a11yr', 20:57:33 INFO - 'ts_paint', 20:57:33 INFO - 'tpaint', 20:57:33 INFO - 'sessionrestore', 20:57:33 INFO - 'sessionrestore_no_auto_restore', 20:57:33 INFO - 'tabpaint']}, 20:57:33 INFO - 'other-e10s': {'tests': ['a11yr', 20:57:33 INFO - 'ts_paint', 20:57:33 INFO - 'tpaint', 20:57:33 INFO - 'sessionrestore', 20:57:33 INFO - 'sessionrestore_no_auto_restore', 20:57:33 INFO - 'tabpaint']}, 20:57:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:57:33 INFO - 'ts_paint', 20:57:33 INFO - 'tpaint', 20:57:33 INFO - 'sessionrestore', 20:57:33 INFO - 'sessionrestore_no_auto_restore', 20:57:33 INFO - 'tabpaint']}, 20:57:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:57:33 INFO - 'ts_paint', 20:57:33 INFO - 'tpaint', 20:57:33 INFO - 'sessionrestore', 20:57:33 INFO - 'sessionrestore_no_auto_restore', 20:57:33 INFO - 'tabpaint']}, 20:57:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:57:33 INFO - 'tests': ['a11yr', 20:57:33 INFO - 'ts_paint', 20:57:33 INFO - 'tpaint', 20:57:33 INFO - 'sessionrestore', 20:57:33 INFO - 'sessionrestore_no_auto_restore', 20:57:33 INFO - 'tabpaint']}, 20:57:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:57:33 INFO - 'tests': ['a11yr', 20:57:33 INFO - 'ts_paint', 20:57:33 INFO - 'tpaint', 20:57:33 INFO - 'sessionrestore', 20:57:33 INFO - 'sessionrestore_no_auto_restore', 20:57:33 INFO - 'tabpaint']}, 20:57:33 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 20:57:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 20:57:33 INFO - 'bloom_basic_ref']}, 20:57:33 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 20:57:33 INFO - 'talos_options': ['--mitmproxy', 20:57:33 INFO - 'mitmproxy-recording-1.mp', 20:57:33 INFO - '--firstNonBlankPaint'], 20:57:33 INFO - 'tests': ['Quantum_1']}, 20:57:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:57:33 INFO - 'tests': ['tsvgx', 20:57:33 INFO - 'tsvgr_opacity', 20:57:33 INFO - 'tart', 20:57:33 INFO - 'tscrollx', 20:57:33 INFO - 'cart', 20:57:33 INFO - 'tsvg_static']}, 20:57:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:57:33 INFO - 'tsvgr_opacity', 20:57:33 INFO - 'tart', 20:57:33 INFO - 'tscrollx', 20:57:33 INFO - 'cart', 20:57:33 INFO - 'tsvg_static']}, 20:57:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:57:33 INFO - 'talos_options': ['--disable-e10s'], 20:57:33 INFO - 'tests': ['tp5o']}, 20:57:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:57:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:57:33 INFO - 'talos_options': ['--disable-e10s', 20:57:33 INFO - '--xperf_path', 20:57:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:57:33 INFO - 'tests': ['tp5n']}, 20:57:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:57:33 INFO - 'talos_options': ['--xperf_path', 20:57:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:57:33 INFO - 'tests': ['tp5n']}}, 20:57:33 INFO - 'talos.zip': {'path': '', 20:57:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:57:33 INFO - Running post-action listener: _resource_record_post_action 20:57:33 INFO - [mozharness: 2017-06-08 03:57:33.168804Z] Finished populate-webroot step (success) 20:57:33 INFO - [mozharness: 2017-06-08 03:57:33.168898Z] Running create-virtualenv step. 20:57:33 INFO - Running pre-action listener: _resource_record_pre_action 20:57:33 INFO - Running main action method: create_virtualenv 20:57:33 INFO - Creating virtualenv /builds/slave/test/build/venv 20:57:33 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 20:57:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:57:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:57:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:57:33 INFO - Using real prefix '/usr' 20:57:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:57:33 INFO - Installing distribute.............................................................................................................................................................................................done. 20:57:35 INFO - Installing pip.................done. 20:57:35 INFO - Return code: 0 20:57:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:57:35 INFO - Reading from file tmpfile_stdout 20:57:35 INFO - Output received: 20:57:35 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) 20:57:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:35 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 0x127e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1458a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa140>, '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 0x15faa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15faed0>, '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': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', '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 20:57:35 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 20:57:35 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 20:57:35 INFO - Using env: {'DISPLAY': ':0', 20:57:35 INFO - 'HOME': '/home/cltbld', 20:57:35 INFO - 'LANG': 'en_US.UTF-8', 20:57:35 INFO - 'LANGUAGE': 'en_US:en', 20:57:35 INFO - 'LOGNAME': 'cltbld', 20:57:35 INFO - 'MAIL': '/var/mail/cltbld', 20:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:35 INFO - 'MOZ_NO_REMOTE': '1', 20:57:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:35 INFO - 'NO_EM_RESTART': '1', 20:57:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:35 INFO - 'PWD': '/builds/slave/test', 20:57:35 INFO - 'SHELL': '/bin/bash', 20:57:35 INFO - 'SHLVL': '1', 20:57:35 INFO - 'TERM': 'linux', 20:57:35 INFO - 'TMOUT': '86400', 20:57:35 INFO - 'USER': 'cltbld', 20:57:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', 20:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:35 INFO - '_': '/tools/buildbot/bin/python'} 20:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:36 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 20:57:36 INFO - Cleaning up... 20:57:36 INFO - Return code: 0 20:57:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x127e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1458a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa140>, '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 0x15faa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15faed0>, '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': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', '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 20:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:57:36 INFO - Using env: {'DISPLAY': ':0', 20:57:36 INFO - 'HOME': '/home/cltbld', 20:57:36 INFO - 'LANG': 'en_US.UTF-8', 20:57:36 INFO - 'LANGUAGE': 'en_US:en', 20:57:36 INFO - 'LOGNAME': 'cltbld', 20:57:36 INFO - 'MAIL': '/var/mail/cltbld', 20:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:36 INFO - 'MOZ_NO_REMOTE': '1', 20:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:36 INFO - 'NO_EM_RESTART': '1', 20:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:36 INFO - 'PWD': '/builds/slave/test', 20:57:36 INFO - 'SHELL': '/bin/bash', 20:57:36 INFO - 'SHLVL': '1', 20:57:36 INFO - 'TERM': 'linux', 20:57:36 INFO - 'TMOUT': '86400', 20:57:36 INFO - 'USER': 'cltbld', 20:57:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', 20:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:36 INFO - '_': '/tools/buildbot/bin/python'} 20:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:36 INFO - Downloading/unpacking psutil>=3.1.1 20:57:36 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 20:57:36 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 20:57:36 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 20:57:36 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 20:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:57:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:57:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:57:37 INFO - Installing collected packages: psutil 20:57:37 INFO - Running setup.py install for psutil 20:57:37 INFO - building 'psutil._psutil_linux' extension 20:57:37 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 20:57:37 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 20:57:37 INFO - building 'psutil._psutil_posix' extension 20:57:37 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 20:57:37 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 20:57:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:57:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:57:38 INFO - Successfully installed psutil 20:57:38 INFO - Cleaning up... 20:57:38 INFO - Return code: 0 20:57:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:57:38 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')]} 20:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:38 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')]} 20:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:38 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 0x127e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1458a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa140>, '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 0x15faa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15faed0>, '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': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', '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 20:57:38 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 20:57:38 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 20:57:38 INFO - Using env: {'DISPLAY': ':0', 20:57:38 INFO - 'HOME': '/home/cltbld', 20:57:38 INFO - 'LANG': 'en_US.UTF-8', 20:57:38 INFO - 'LANGUAGE': 'en_US:en', 20:57:38 INFO - 'LOGNAME': 'cltbld', 20:57:38 INFO - 'MAIL': '/var/mail/cltbld', 20:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:38 INFO - 'MOZ_NO_REMOTE': '1', 20:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:38 INFO - 'NO_EM_RESTART': '1', 20:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:38 INFO - 'PWD': '/builds/slave/test', 20:57:38 INFO - 'SHELL': '/bin/bash', 20:57:38 INFO - 'SHLVL': '1', 20:57:38 INFO - 'TERM': 'linux', 20:57:38 INFO - 'TMOUT': '86400', 20:57:38 INFO - 'USER': 'cltbld', 20:57:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', 20:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:38 INFO - '_': '/tools/buildbot/bin/python'} 20:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:57:39 INFO - Installing collected packages: mozsystemmonitor 20:57:39 INFO - Running setup.py install for mozsystemmonitor 20:57:39 INFO - Successfully installed mozsystemmonitor 20:57:39 INFO - Cleaning up... 20:57:39 INFO - Return code: 0 20:57:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:57:39 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')]} 20:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:39 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')]} 20:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:39 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 0x127e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1458a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa140>, '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 0x15faa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15faed0>, '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': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', '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 20:57:39 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 20:57:39 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 20:57:39 INFO - Using env: {'DISPLAY': ':0', 20:57:39 INFO - 'HOME': '/home/cltbld', 20:57:39 INFO - 'LANG': 'en_US.UTF-8', 20:57:39 INFO - 'LANGUAGE': 'en_US:en', 20:57:39 INFO - 'LOGNAME': 'cltbld', 20:57:39 INFO - 'MAIL': '/var/mail/cltbld', 20:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:39 INFO - 'MOZ_NO_REMOTE': '1', 20:57:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:39 INFO - 'NO_EM_RESTART': '1', 20:57:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:39 INFO - 'PWD': '/builds/slave/test', 20:57:39 INFO - 'SHELL': '/bin/bash', 20:57:39 INFO - 'SHLVL': '1', 20:57:39 INFO - 'TERM': 'linux', 20:57:39 INFO - 'TMOUT': '86400', 20:57:39 INFO - 'USER': 'cltbld', 20:57:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', 20:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:39 INFO - '_': '/tools/buildbot/bin/python'} 20:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:39 INFO - Downloading/unpacking jsonschema==2.5.1 20:57:39 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 20:57:39 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 20:57:39 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 20:57:39 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 20:57:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:57:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:41 INFO - Downloading functools32-3.2.3-2.tar.gz 20:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:57:41 INFO - warning: no files found matching '*.txt' 20:57:41 INFO - no previously-included directories found matching 'build' 20:57:41 INFO - no previously-included directories found matching 'dist' 20:57:41 INFO - no previously-included directories found matching '.git*' 20:57:41 INFO - Installing collected packages: jsonschema, functools32 20:57:41 INFO - Running setup.py install for functools32 20:57:41 INFO - warning: no files found matching '*.txt' 20:57:41 INFO - no previously-included directories found matching 'build' 20:57:41 INFO - no previously-included directories found matching 'dist' 20:57:41 INFO - no previously-included directories found matching '.git*' 20:57:41 INFO - Successfully installed jsonschema functools32 20:57:41 INFO - Cleaning up... 20:57:41 INFO - Return code: 0 20:57:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x127e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1458a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa140>, '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 0x15faa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15faed0>, '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': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', '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 20:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:57:41 INFO - Using env: {'DISPLAY': ':0', 20:57:41 INFO - 'HOME': '/home/cltbld', 20:57:41 INFO - 'LANG': 'en_US.UTF-8', 20:57:41 INFO - 'LANGUAGE': 'en_US:en', 20:57:41 INFO - 'LOGNAME': 'cltbld', 20:57:41 INFO - 'MAIL': '/var/mail/cltbld', 20:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:41 INFO - 'MOZ_NO_REMOTE': '1', 20:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:41 INFO - 'NO_EM_RESTART': '1', 20:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:41 INFO - 'PWD': '/builds/slave/test', 20:57:41 INFO - 'SHELL': '/bin/bash', 20:57:41 INFO - 'SHLVL': '1', 20:57:41 INFO - 'TERM': 'linux', 20:57:41 INFO - 'TMOUT': '86400', 20:57:41 INFO - 'USER': 'cltbld', 20:57:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', 20:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:41 INFO - '_': '/tools/buildbot/bin/python'} 20:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:57:41 INFO - Cleaning up... 20:57:41 INFO - Return code: 0 20:57:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x127e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1458a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa140>, '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 0x15faa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15faed0>, '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': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', '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 20:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:57:41 INFO - Using env: {'DISPLAY': ':0', 20:57:41 INFO - 'HOME': '/home/cltbld', 20:57:41 INFO - 'LANG': 'en_US.UTF-8', 20:57:41 INFO - 'LANGUAGE': 'en_US:en', 20:57:41 INFO - 'LOGNAME': 'cltbld', 20:57:41 INFO - 'MAIL': '/var/mail/cltbld', 20:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:41 INFO - 'MOZ_NO_REMOTE': '1', 20:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:41 INFO - 'NO_EM_RESTART': '1', 20:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:41 INFO - 'PWD': '/builds/slave/test', 20:57:41 INFO - 'SHELL': '/bin/bash', 20:57:41 INFO - 'SHLVL': '1', 20:57:41 INFO - 'TERM': 'linux', 20:57:41 INFO - 'TMOUT': '86400', 20:57:41 INFO - 'USER': 'cltbld', 20:57:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', 20:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:41 INFO - '_': '/tools/buildbot/bin/python'} 20:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:41 INFO - Downloading/unpacking blobuploader==1.2.4 20:57:41 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 20:57:41 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 20:57:41 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 20:57:41 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 20:57:42 INFO - Downloading blobuploader-1.2.4.tar.gz 20:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:57:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:57:42 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 20:57:42 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 20:57:42 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 20:57:42 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 20:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:57:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:43 INFO - Downloading docopt-0.6.1.tar.gz 20:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:57:43 INFO - Installing collected packages: blobuploader, requests, docopt 20:57:43 INFO - Running setup.py install for blobuploader 20:57:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:57:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:57:43 INFO - Running setup.py install for requests 20:57:43 INFO - Running setup.py install for docopt 20:57:43 INFO - Successfully installed blobuploader requests docopt 20:57:43 INFO - Cleaning up... 20:57:43 INFO - Return code: 0 20:57:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:43 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')]} 20:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:43 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')]} 20:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:43 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 0x127e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1458a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa140>, '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 0x15faa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15faed0>, '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': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', '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 20:57:43 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 20:57:43 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 20:57:43 INFO - Using env: {'DISPLAY': ':0', 20:57:43 INFO - 'HOME': '/home/cltbld', 20:57:43 INFO - 'LANG': 'en_US.UTF-8', 20:57:43 INFO - 'LANGUAGE': 'en_US:en', 20:57:43 INFO - 'LOGNAME': 'cltbld', 20:57:43 INFO - 'MAIL': '/var/mail/cltbld', 20:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:43 INFO - 'MOZ_NO_REMOTE': '1', 20:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:43 INFO - 'NO_EM_RESTART': '1', 20:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:43 INFO - 'PWD': '/builds/slave/test', 20:57:43 INFO - 'SHELL': '/bin/bash', 20:57:43 INFO - 'SHLVL': '1', 20:57:43 INFO - 'TERM': 'linux', 20:57:43 INFO - 'TMOUT': '86400', 20:57:43 INFO - 'USER': 'cltbld', 20:57:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', 20:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:43 INFO - '_': '/tools/buildbot/bin/python'} 20:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:57:44 INFO - Running setup.py (path:/tmp/pip-vjp4Of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:57:44 INFO - Running setup.py (path:/tmp/pip-63FhHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:57:44 INFO - Running setup.py (path:/tmp/pip-cKH8uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:57:44 INFO - Running setup.py (path:/tmp/pip-h8fqe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:57:44 INFO - Running setup.py (path:/tmp/pip-RoIyoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:57:44 INFO - Running setup.py (path:/tmp/pip-0xJRfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:57:44 INFO - Running setup.py (path:/tmp/pip-ftSwur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:44 INFO - Running setup.py (path:/tmp/pip-eIOVWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:44 INFO - Running setup.py (path:/tmp/pip-ERChko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:44 INFO - Running setup.py (path:/tmp/pip-bnw0Lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:44 INFO - Running setup.py (path:/tmp/pip-NtPTGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:44 INFO - Running setup.py (path:/tmp/pip-vxgVe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:45 INFO - Running setup.py (path:/tmp/pip-0g1BVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:45 INFO - Running setup.py (path:/tmp/pip-AYd6Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:45 INFO - Running setup.py (path:/tmp/pip-aP6amM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:45 INFO - Running setup.py (path:/tmp/pip-F0lEOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:45 INFO - Running setup.py (path:/tmp/pip-GUO6Ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:57:45 INFO - Running setup.py install for manifestparser 20:57:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:57:45 INFO - Running setup.py install for mozcrash 20:57:45 INFO - Running setup.py install for mozdebug 20:57:45 INFO - Running setup.py install for mozdevice 20:57:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:57:45 INFO - Running setup.py install for mozfile 20:57:45 INFO - Running setup.py install for mozhttpd 20:57:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:57:46 INFO - Running setup.py install for mozinfo 20:57:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:57:46 INFO - Running setup.py install for mozInstall 20:57:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:57:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:57:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:57:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:57:46 INFO - Running setup.py install for mozleak 20:57:46 INFO - Running setup.py install for mozlog 20:57:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:57:46 INFO - Running setup.py install for moznetwork 20:57:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:57:46 INFO - Running setup.py install for mozprocess 20:57:46 INFO - Running setup.py install for mozprofile 20:57:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:57:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:57:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:57:46 INFO - Running setup.py install for mozrunner 20:57:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:57:46 INFO - Running setup.py install for mozscreenshot 20:57:46 INFO - Running setup.py install for moztest 20:57:47 INFO - Running setup.py install for mozversion 20:57:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:57:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:57:47 INFO - Cleaning up... 20:57:47 INFO - Return code: 0 20:57:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:47 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')]} 20:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:47 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')]} 20:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:47 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 0x127e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1458a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa140>, '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 0x15faa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15faed0>, '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': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', '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 20:57:47 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 20:57:47 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 20:57:47 INFO - Using env: {'DISPLAY': ':0', 20:57:47 INFO - 'HOME': '/home/cltbld', 20:57:47 INFO - 'LANG': 'en_US.UTF-8', 20:57:47 INFO - 'LANGUAGE': 'en_US:en', 20:57:47 INFO - 'LOGNAME': 'cltbld', 20:57:47 INFO - 'MAIL': '/var/mail/cltbld', 20:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:47 INFO - 'MOZ_NO_REMOTE': '1', 20:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:47 INFO - 'NO_EM_RESTART': '1', 20:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:47 INFO - 'PWD': '/builds/slave/test', 20:57:47 INFO - 'SHELL': '/bin/bash', 20:57:47 INFO - 'SHLVL': '1', 20:57:47 INFO - 'TERM': 'linux', 20:57:47 INFO - 'TMOUT': '86400', 20:57:47 INFO - 'USER': 'cltbld', 20:57:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', 20:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:47 INFO - '_': '/tools/buildbot/bin/python'} 20:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:57:47 INFO - Running setup.py (path:/tmp/pip-6goE34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:57:47 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)) 20:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:57:47 INFO - Running setup.py (path:/tmp/pip-FZyIw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:57:47 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)) 20:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:57:47 INFO - Running setup.py (path:/tmp/pip-XOeZvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:57:47 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)) 20:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:57:47 INFO - Running setup.py (path:/tmp/pip-OJ3TIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:57:47 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)) 20:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:57:47 INFO - Running setup.py (path:/tmp/pip-5JbYl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:57:47 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)) 20:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:57:47 INFO - Running setup.py (path:/tmp/pip-bw0IUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:57:47 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)) 20:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:57:47 INFO - Running setup.py (path:/tmp/pip-YVo9cP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:47 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)) 20:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:47 INFO - Running setup.py (path:/tmp/pip-y9Oqaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:47 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)) 20:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:47 INFO - Running setup.py (path:/tmp/pip-0QmswH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:48 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)) 20:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:48 INFO - Running setup.py (path:/tmp/pip-1pwyHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:48 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)) 20:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:48 INFO - Running setup.py (path:/tmp/pip-TtEoEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:48 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)) 20:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:48 INFO - Running setup.py (path:/tmp/pip-pUpFKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:48 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)) 20:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:48 INFO - Running setup.py (path:/tmp/pip-a60iiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:48 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)) 20:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:48 INFO - Running setup.py (path:/tmp/pip-MPPJz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:48 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)) 20:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:48 INFO - Running setup.py (path:/tmp/pip-vmAsYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:48 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)) 20:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:48 INFO - Running setup.py (path:/tmp/pip-o5IkIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:48 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)) 20:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:48 INFO - Running setup.py (path:/tmp/pip-WOv03c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:48 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)) 20:57:48 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)) 20:57:48 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)) 20:57:48 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)) 20:57:48 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)) 20:57:48 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)) 20:57:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:57:48 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 20:57:48 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 20:57:48 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 20:57:48 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 20:57:49 INFO - Downloading blessings-1.6.tar.gz 20:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:57:49 INFO - Installing collected packages: blessings 20:57:49 INFO - Running setup.py install for blessings 20:57:49 INFO - Successfully installed blessings 20:57:49 INFO - Cleaning up... 20:57:49 INFO - Return code: 0 20:57:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:57:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:50 INFO - Reading from file tmpfile_stdout 20:57:50 INFO - Current package versions: 20:57:50 INFO - argparse == 1.2.1 20:57:50 INFO - blessings == 1.6 20:57:50 INFO - blobuploader == 1.2.4 20:57:50 INFO - docopt == 0.6.1 20:57:50 INFO - functools32 == 3.2.3-2 20:57:50 INFO - jsonschema == 2.5.1 20:57:50 INFO - manifestparser == 1.1 20:57:50 INFO - mozInstall == 1.12 20:57:50 INFO - mozcrash == 1.0 20:57:50 INFO - mozdebug == 0.1 20:57:50 INFO - mozdevice == 0.51 20:57:50 INFO - mozfile == 1.2 20:57:50 INFO - mozhttpd == 0.7 20:57:50 INFO - mozinfo == 0.10 20:57:50 INFO - mozleak == 0.1 20:57:50 INFO - mozlog == 3.4 20:57:50 INFO - moznetwork == 0.27 20:57:50 INFO - mozprocess == 0.25 20:57:50 INFO - mozprofile == 0.28 20:57:50 INFO - mozrunner == 6.13 20:57:50 INFO - mozscreenshot == 0.1 20:57:50 INFO - mozsystemmonitor == 0.3 20:57:50 INFO - moztest == 0.8 20:57:50 INFO - mozversion == 1.4 20:57:50 INFO - psutil == 3.1.1 20:57:50 INFO - requests == 1.2.3 20:57:50 INFO - wsgiref == 0.1.2 20:57:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:50 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')]} 20:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:50 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')]} 20:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:50 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 0x127e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1458a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa140>, '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 0x15faa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15faed0>, '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': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', '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 20:57:50 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 20:57:50 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 20:57:50 INFO - Using env: {'DISPLAY': ':0', 20:57:50 INFO - 'HOME': '/home/cltbld', 20:57:50 INFO - 'LANG': 'en_US.UTF-8', 20:57:50 INFO - 'LANGUAGE': 'en_US:en', 20:57:50 INFO - 'LOGNAME': 'cltbld', 20:57:50 INFO - 'MAIL': '/var/mail/cltbld', 20:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:50 INFO - 'MOZ_NO_REMOTE': '1', 20:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:50 INFO - 'NO_EM_RESTART': '1', 20:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:50 INFO - 'PWD': '/builds/slave/test', 20:57:50 INFO - 'SHELL': '/bin/bash', 20:57:50 INFO - 'SHLVL': '1', 20:57:50 INFO - 'TERM': 'linux', 20:57:50 INFO - 'TMOUT': '86400', 20:57:50 INFO - 'USER': 'cltbld', 20:57:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', 20:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:50 INFO - '_': '/tools/buildbot/bin/python'} 20:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:50 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)) 20:57:50 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)) 20:57:50 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)) 20:57:50 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)) 20:57:50 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)) 20:57:50 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)) 20:57:50 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)) 20:57:50 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)) 20:57:50 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)) 20:57:50 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:57:50 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 20:57:50 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 20:57:50 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 20:57:50 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 20:57:51 INFO - Downloading marionette_driver-1.4.0.tar.gz 20:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 20:57:51 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)) 20:57:51 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)) 20:57:51 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)) 20:57:51 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)) 20:57:51 INFO - Installing collected packages: marionette-driver 20:57:51 INFO - Running setup.py install for marionette-driver 20:57:51 INFO - Successfully installed marionette-driver 20:57:51 INFO - Cleaning up... 20:57:51 INFO - Return code: 0 20:57:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:57: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')]} 20:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57: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')]} 20:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:51 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 0x127e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1458a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fa140>, '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 0x15faa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15faed0>, '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': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', '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 20:57:51 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 20:57:51 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 20:57:51 INFO - Using env: {'DISPLAY': ':0', 20:57:51 INFO - 'HOME': '/home/cltbld', 20:57:51 INFO - 'LANG': 'en_US.UTF-8', 20:57:51 INFO - 'LANGUAGE': 'en_US:en', 20:57:51 INFO - 'LOGNAME': 'cltbld', 20:57:51 INFO - 'MAIL': '/var/mail/cltbld', 20:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:51 INFO - 'MOZ_NO_REMOTE': '1', 20:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:51 INFO - 'NO_EM_RESTART': '1', 20:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:51 INFO - 'PWD': '/builds/slave/test', 20:57:51 INFO - 'SHELL': '/bin/bash', 20:57:51 INFO - 'SHLVL': '1', 20:57:51 INFO - 'TERM': 'linux', 20:57:51 INFO - 'TMOUT': '86400', 20:57:51 INFO - 'USER': 'cltbld', 20:57:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', 20:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:51 INFO - '_': '/tools/buildbot/bin/python'} 20:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:57:51 INFO - Cleaning up... 20:57:51 INFO - Return code: 0 20:57:51 INFO - Running post-action listener: _resource_record_post_action 20:57:51 INFO - Running post-action listener: _start_resource_monitoring 20:57:51 INFO - Starting resource monitoring. 20:57:51 INFO - [mozharness: 2017-06-08 03:57:51.982066Z] Finished create-virtualenv step (success) 20:57:51 INFO - [mozharness: 2017-06-08 03:57:51.982532Z] Running install step. 20:57:51 INFO - Running pre-action listener: _resource_record_pre_action 20:57:51 INFO - Running main action method: install 20:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:52 INFO - Reading from file tmpfile_stdout 20:57:52 INFO - Detecting whether we're running mozinstall >=1.0... 20:57:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:57:52 INFO - Reading from file tmpfile_stdout 20:57:52 INFO - Output received: 20:57:52 INFO - Usage: mozinstall [options] installer 20:57:52 INFO - Options: 20:57:52 INFO - -h, --help show this help message and exit 20:57:52 INFO - -d DEST, --destination=DEST 20:57:52 INFO - Directory to install application into. [default: 20:57:52 INFO - "/builds/slave/test"] 20:57:52 INFO - --app=APP Application being installed. [default: firefox] 20:57:52 INFO - mkdir: /builds/slave/test/build/application 20:57:52 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'] 20:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:58:09 INFO - Reading from file tmpfile_stdout 20:58:09 INFO - Output received: 20:58:09 INFO - /builds/slave/test/build/application/firefox/firefox 20:58:09 INFO - Running post-action listener: _resource_record_post_action 20:58:09 INFO - [mozharness: 2017-06-08 03:58:09.114265Z] Finished install step (success) 20:58:09 INFO - [mozharness: 2017-06-08 03:58:09.114542Z] Running setup-mitmproxy step. 20:58:09 INFO - Running pre-action listener: _resource_record_pre_action 20:58:09 INFO - Running main action method: setup_mitmproxy 20:58:09 INFO - Skipping: mitmproxy is not required 20:58:09 INFO - Running post-action listener: _resource_record_post_action 20:58:09 INFO - [mozharness: 2017-06-08 03:58:09.115658Z] Finished setup-mitmproxy step (success) 20:58:09 INFO - [mozharness: 2017-06-08 03:58:09.115876Z] Running run-tests step. 20:58:09 INFO - Running pre-action listener: _resource_record_pre_action 20:58:09 INFO - Running main action method: run_tests 20:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:58:09 INFO - Python 2.7.3 20:58:09 INFO - Return code: 0 20:58:09 INFO - grabbing minidump binary from tooltool 20:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:58:09 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 0x15fa140>, '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 0x15faa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15faed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:58:09 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 20:58:09 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 20:58:09 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 20:58:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:58:09 INFO - Return code: 0 20:58:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:58:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:58:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:58:09 INFO - ENV: RUST_BACKTRACE is now 1 20:58:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:58:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:58:09 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/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 20:58:09 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/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 20:58:09 INFO - Using env: {'DISPLAY': ':0', 20:58:09 INFO - 'HOME': '/home/cltbld', 20:58:09 INFO - 'LANG': 'en_US.UTF-8', 20:58:09 INFO - 'LANGUAGE': 'en_US:en', 20:58:09 INFO - 'LOGNAME': 'cltbld', 20:58:09 INFO - 'MAIL': '/var/mail/cltbld', 20:58:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:58:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:09 INFO - 'MOZ_NO_REMOTE': '1', 20:58:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:58:09 INFO - 'NO_EM_RESTART': '1', 20:58:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:09 INFO - 'PWD': '/builds/slave/test', 20:58:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:58:09 INFO - 'RUST_BACKTRACE': '1', 20:58:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:58:09 INFO - 'SHELL': '/bin/bash', 20:58:09 INFO - 'SHLVL': '1', 20:58:09 INFO - 'TERM': 'linux', 20:58:09 INFO - 'TMOUT': '86400', 20:58:09 INFO - 'USER': 'cltbld', 20:58:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653', 20:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:09 INFO - '_': '/tools/buildbot/bin/python'} 20:58:09 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/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 20:58:09 INFO - mozversion application_buildid: 20170608025514 20:58:09 INFO - mozversion application_changeset: 7efda263a842e60cd0cc00b3c4a7058c65590702 20:58:09 INFO - mozversion application_display_name: Nightly 20:58:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:58:09 INFO - mozversion application_name: Firefox 20:58:09 INFO - mozversion application_remotingname: firefox 20:58:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:58:09 INFO - mozversion application_vendor: Mozilla 20:58:09 INFO - mozversion application_version: 55.0a1 20:58:09 INFO - mozversion platform_buildid: 20170608025514 20:58:09 INFO - mozversion platform_changeset: 7efda263a842e60cd0cc00b3c4a7058c65590702 20:58:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:58:09 INFO - mozversion platform_version: 55.0a1 20:58:09 INFO - using testdate: 1496894289 20:58:09 INFO - actual date: 1496894289 20:58:09 INFO - starting webserver on 'localhost:57708' 20:58:09 INFO - SUITE-START | Running 2 tests 20:58:09 INFO - TEST-START | dromaeo_css 20:58:09 INFO - operating with platform_type : linux_ 20:58:09 INFO - Initialising browser for dromaeo_css test... 20:58:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57708/getInfo.html -profile /tmp/tmpd6zG2G/profile 20:58:09 INFO - TEST-INFO | started process 4553 (/builds/slave/test/build/application/firefox/firefox http://localhost:57708/getInfo.html) 20:58:44 INFO - TEST-INFO | 4553: killed by SIGTERM 20:58:44 INFO - Browser initialized. 20:58:44 INFO - Running cycle 1/1 for dromaeo_css test... 20:58:44 INFO - TEST-INFO | started process 4761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd6zG2G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:58:56 INFO - PID 4761 | RSS: Main: 177856512 20:58:56 INFO - PID 4761 | 21:01:55 INFO - PID 4761 | Cycle 1(1): loaded http://localhost:57708/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57708/tests/dromaeo/cssquery-ext.html) 21:01:57 INFO - PID 4761 | RSS: Main: 176431104 21:01:57 INFO - PID 4761 | 21:04:59 INFO - PID 4761 | Cycle 1(1): loaded http://localhost:57708/tests/dromaeo/cssquery-ext.html (next: http://localhost:57708/tests/dromaeo/cssquery-jquery.html) 21:04:59 INFO - PID 4761 | RSS: Main: 179195904 21:04:59 INFO - PID 4761 | 21:08:01 INFO - PID 4761 | Cycle 1(1): loaded http://localhost:57708/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57708/tests/dromaeo/cssquery-mootools.html) 21:08:02 INFO - PID 4761 | RSS: Main: 177373184 21:08:02 INFO - PID 4761 | 21:11:03 INFO - PID 4761 | Cycle 1(1): loaded http://localhost:57708/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57708/tests/dromaeo/cssquery-prototype.html) 21:11:04 INFO - PID 4761 | RSS: Main: 180666368 21:11:04 INFO - PID 4761 | 21:14:07 INFO - PID 4761 | Cycle 1(1): loaded http://localhost:57708/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57708/tests/dromaeo/cssquery-yui.html) 21:14:07 INFO - PID 4761 | RSS: Main: 178806784 21:14:07 INFO - PID 4761 | 21:17:09 INFO - PID 4761 | Cycle 1(1): loaded http://localhost:57708/tests/dromaeo/cssquery-yui.html (next: http://localhost:57708/tests/dromaeo/cssquery-dojo.html) 21:17:09 INFO - PID 4761 | RSS: Main: 179036160 21:17:09 INFO - PID 4761 | 21:17:09 INFO - PID 4761 | __start_tp_report 21:17:09 INFO - PID 4761 | _x_x_mozilla_page_load 21:17:09 INFO - PID 4761 | _x_x_mozilla_page_load_details 21:17:09 INFO - PID 4761 | |i|pagename|runs| 21:17:09 INFO - PID 4761 | |0;dojo.html;3353.8323083845808;3394.5587073680435;3400.931981360373;3401.9489707654407;3410.317936412718;5933.643981361121;6008.759649614016;6014.458698717114;6028.186194863692;6028.517718582509;5977.372375900533;6012.098185272201;6048.425399587032;6057.42454466825;6110.602810817294;4998.125328067592;5262;5343.973280133594;5369.973150134244;5389.703566303851;5390.9191362129595;5418.783248670048;5442.755076021588;5443.047466693313;5454.236406903036;5240.973795131038;5315.548178404821;5336.9733151334385;5367.785288588452;5367.812126575571;5392.487713667196;5394.379646340682;5406.270153529263;5412.377576578704;5418.756155972991;5355.303810504648;5369.785208591652;5374.274472946141;5374.758135883855;5400.756965936543;5867.8533036674;5960.046392577166;5985.132155837379;6038.124471951586;6052.72762725674;6507.837304067436;6531.510136739716;6533.379328963741;6543.345665433466;6549.738010479623;6569.540132190748;6574.671266436659;6579.17760279965;6582.473402127818;6589.472842172662;6020.277566692025;6059.303180134341;6062.636241825505;6123.265208175003;6135.815925522242;6659.067730517731;6683.298253683293;6689.665516724144;6690.96654516734;6710.765123220762;6230.408111229426;6347.492200623939;6373.203349581302;6405.871882562323;6414.454771344394;6507.9023814642815;6509.609423434609;6529.804105876831;6532.510061745293;6554.082428460019;6363.7772677956045;6377.585456945284;6433.260175079926;6455.677216139175;6487.091807147003;6486.059521369375;6502.6748662567625;6518.967405163039;6543.574667646588;6555.2133743951035;4934.1611925972675;4945.727984960861;4948.505149485023;4952.380952380952;4975;4315;4392.05570802279;4392.2094023075515;4395.604395604411;4398.604125628709;6063;6118.388161183846;6143.757528502154;6148.200733904564;6171;6582.341765823475;6586.80239592813;6587.176602924635;6588.703508342041;6633.436157926534;6149.200603921461;6170.444659980623;6170.50635949123;6177.351378105324;6182.629042257479;5443.482869127427;5444;5468.371137319259;5483.095289277305;5499.917501237484;6768.593884366954;6774.187097548326;6781.4574834013165;6783.321667833177;6798.966005170041;6574.671266436563;6584.604923704593;6597.373249541286;6597.934020659732;6618.702158402787;6661.467082633475;6689.364510371507;6727.596344219362;6728.932710672831;6812.727490900506;6420;6429.067785171217;6430.453411460078;6464.191976003;6488.740450382121;6597.571157874723;6610.603363798187;6619;6621.900671490028;6624.867502650017;6268.52986026059;6277.96861015692;6325.841853953688;6366.586171898812;6373.776917807854;6343.873122537616;6388.616682999035;6395;6398.840028999126;6423.261324947691;6371.840703982438;6372.968135159294;6381.361863813581;6392.648404337806;6393.8721225576155;6260.060990851409;6332.11350410952;6351.872962540631;6410.45511131559;6439.774607888701;6247.531435142473;6250.718717657625;6267.811965641038;6293.4335909766505;6294.244690637152 21:17:09 INFO - PID 4761 | |1;ext.html;762.843617058503;833.6582001379434;851.8296340731852;1141.9486123124464;1144.8111061674824;37393.62606373936;38698.41952370713;38732.0316992075;38864.805675971584;38867.805660971724;41615.79192104043;41979.58020419795;41991.370129448085;42145.15709685804;42234.36648450276;7026.332498412656;7105.218425973138;7329.413646908234;7335.4498412619005;7343.669534870917;7261.927380726178;7320.158181809107;7332.560046397233;7336.559806411606;7369.4841361104745;7323.8535229295385;7384.076990376203;7386.593737344444;7401.70393184272;7416.369608583277;7285.162206346232;7348.669309881041;7354.7425840095875;7356.264373562654;7372.815679607999;7089.184743754483;7147.249538798404;7174.605396703179;7179.89230161548;7190.712371505134;38450.42324365137;38831.61168388336;38871.41692874609;38948.415773763416;38966.415503767465;3549.165946002687;3559.430491121434;3564.518789963374;3567.518385018015;3584.193556449778;29494.705052949626;29509.852450737824;29586;29596.70403295961;29606.25984350387;3644.9817750911343;3658.304922064826;3680.1351682354625;3690.9630903690886;3695.2055308108884;154171;158539;158547.20726396408;196737;198650;42918.35622465666;42922.14155716868;43029.56970430256;43116.568834311256;43122.78438607787;43849.34225986613;43976;56339.43660563424;57409;57549.41027653766;15101.924490377698;15393.769093463607;15405.075695458308;15415.152166630944;15446.150461724714;12186.634400967809;12316.261024338568;12316.81524777129;12317.50729970809;12331.50673973031;15142.621434464227;15224.467143650141;15228.771568426482;15292.08247505131;15429.691406172038;5991.670458124758;6009.1587177795145;6049.18336024631;6067.878642427127;6147.569670123048;1058.2327812336148;1085.1806885801327;1089.2756317049232;1093.6718984304678;1099.1920938110482;24863.751362486142;25453.61819572708;25657;26105.347366315993;26142.34644133912;1157.4617802721607;1169.0647482014353;1190.4285942747356;1197.9940100299443;1210.6368089573093;13282.3358832058;13481.59555213345;13890.861091389159;14084.366203520865;14132.293385330693;247060;247148;247759;247991;249069;53877;54073;54236;54400.45599544033;54457;1445.2340259662185;1461.262062658372;1485.4578079001303;1491.2543728135931;1508.7058023685495;24244.393890152183;29429.558556622094;30438.847805761714;31006.53490197694;31101.53347699741;52087.739561301954;52313.21530176974;52584;52616.47383526116;53023;168170;168706;169790;169971.15014424847;170408;35933.281334372645;36306.27387452289;36429.81785091058;36491.452628211126;36523.452148217264;43659;44662.55337446714;45090;45133.77433112814;45400.54599454095;30864.228394290323;31504.842475787475;32603.673963260062;32746.34507309888;34780.304393912484;32361.676383235867;32387.05677659348;32632.83683581567;32667.183320417178;34094;37923.24153516969;38632.42051369175;38961.610383896936;39055;39117;32016.341289223245;32107.678923211402;32157.517637234992;32376.190595235308;32528.83735581307;24899.626505602067;26062.34844128912;26401.207963761117;26612.600810987464;26952.595711064743 21:17:09 INFO - PID 4761 | |2;jquery.html;501.54610077879533;501.64633933077187;504.8561160069381;521.5149910583156;530.2867643020138;20663.38009859703;21369.67945480817;21485.248016319394;21491.140354385807;23879.641805372932;24129.03483860648;24732;24733.628995565083;24746.505069898638;24789.50420991579;5850.853728656775;5945.256842894638;5978.252718410199;5982.611130276518;5995.670238136922;5883.47048765611;5933.6439813611105;5944.64332140073;5951.553633477485;5958.761649534035;5497.45025497451;5717.571182161334;5745.396733343002;5755.798547050854;5766.1639062335935;5698.145278208261;5743.655380677152;5747.856303592402;5748.42515748426;5753.079507278857;5305.867353316159;5331.546818520431;5334.093204155264;5339.70631615261;5342.358916929955;28084.29789255285;28204.576931346048;28504.429911401865;28571.285717857012;28671.28321791951;2204.845660803728;2241.8542794718455;2242.0807468937655;2242.1816037146486;2250.6849041134255;18049.7292540612;18608.44174674762;18616.069196540255;18641.25434982599;18692.158852851655;2194.517206214646;2218.223621732397;2219.04581030157;2235.117128734157;2252.876091814966;122665.38667306607;124898;130106.349468253;130513;130650.3467482666;13890.58328250154;13946.790798138036;14011.859881401055;14183;14434.133951962916;21452.678209826867;21523.461913452287;21560.56878862414;21615.135394584042;21679.34961951144;9000.54997250148;9393.295502837178;9417.905820941703;9492.525373731285;9579.233661307078;8577.914220857836;8636.093210212963;8688.174623410765;8749.868751968726;8805.251553617885;8643.234165067119;8850.380473366931;8914.86627700585;8987.41581797181;9195.264378849675;2498.675172227599;2566.807489438262;2569.79441644668;2597.467519158568;2611.073069060456;1026.820306446369;1031.7008067660445;1040.9843852342221;1069.0699091790193;1097.237419993113;21189.78810211909;21345.25291614786;21399.572008559742;21431;21803.67294490584;1054.6256079091966;1057.1120258982492;1074.5701719312337;1087.7335052911928;1093.573506332531;11330.660080197607;11430.1998860079;11439.656810295704;11577.942110289394;11749.177557570887;507379;508091;513621;530033;532035;109061.45469272761;110511;111180;111693.44153279344;112045;1071.914246860265;1095.4905968724422;1179.0862081886607;1200.237848965913;1228.0605336917088;20377.286794962107;20779.48051298669;21062.789372106698;21214.6451674043;21592.784072159706;49957.50042499528;50774.49225507698;51374.48625513697;51571;52979;65240.67379663261;65633.67183164053;65715.67142164259;65956;66626;11851;12138.939305303416;12156.270623762603;12258.080643951562;12310.815337769762;16864.325426983272;17103.14484275806;17619.29522819124;18110.5472363192;18278.177482013074;15585.844141558438;15654.765178522104;15767.053976761432;15821.288042038366;15853.682926341638;13665.590032299047;13917.721645567235;14095.224762637743;14134.363953621905;14155.64610884736;15121.848781512044;15259;15305.693886121993;15398.307076181374;15466.072035677895;12000.57997970067;12046.216995895238;12059.21615095016;12059.733727958437;12103.878961210627;14940.626484337978;15096.320665569856;15497.922510387376;15543.45597904068;15557.533274001798 21:17:09 INFO - PID 4761 | |3;mootools.html;1341.6444642169824;1404.4452441285687;1404.6207523968528;1406.4163372200537;1419.5741277616712;12970;13506.662333441669;13633.318334083293;13700.657483562916;14052.718945621107;13592.592222233348;13632.113912595674;13740.79388809166;13820.792688109661;13827.23950182742;2351.059576169533;2430.2466235467064;2441.316431399211;2444.633305004246;2446.156076153733;2299.7585253548386;2341.9648705269433;2353.364591560278;2354.693889794324;2363.6809030780796;2370.2059809963685;2383.4637206628545;2386.152915714922;2397.5564520563667;2401.987990060047;2241.764614715448;2298.908043678251;2312.271634435156;2322.3033090072995;2327.7439481657;1995.7405537280206;2075.740532433446;2252.6395776675818;2254.7068881045525;2274.977250227493;13275.933620331933;13380.130291531117;13404.195748255135;13417.865821341758;13419.396127174301;6855.6572171391235;7120.857582848365;7125.1093613298335;7125.144982602121;7127.465440091962;4045.3325201341745;4158;4206.579342065799;4243;4334.956650433487;1554.3394057525506;1556.8053993250844;1566.1307974074384;1577.1483398964544;1591.5384538483827;21647.134114635395;21707.891460542596;21906.12375504978;21928.122875084977;21955.9141881521;5512.4211957744665;5780.942190578125;5792.623479473821;5803.651780893076;5870.4716575507555;15156.24218789056;15218.695626087416;15220.315085821165;15222.771658425132;15276.236188190545;6869.141357330333;7004.859902802017;7007.649617519103;7015.193252775894;7033.085698859218;6417.262014868256;6512.413882750575;6529.54293199481;6566;6606.372394622503;4851.684640498427;4990.426100998359;5014.2979982802435;5037.496250374933;5052.292679024939;1392.8189335386335;1413.6041908265497;1419.0279658434006;1420.2614640386942;1424.0530047518284;903.1420150856712;932.6316105138433;935.1350001248818;936.0592604432638;940.238406890421;7295.124585049828;7450.18048014718;7525.548467091992;7608.923910760932;7757.224277572198;698.769406095987;735.1288722863424;735.4153448008846;739.7226040234912;742.2725728785712;4587.4036375271;4916.514356756856;5242.056429842589;5631.6491687445905;5640.182173584807;17956.91021544884;18314.725279120823;18453;18538.25846966106;18860;18167.72748408775;18260.360887369145;18332.908335458236;18339.174737136862;18552.257909683733;10321;10625.149988000941;10635.202359823044;10655.893441065646;10657.360558366523;7681.569816137006;8512.616932237941;8545.675420309863;8719;9125.133112354315;16596;16799;17011.23449444803;17295.308187672854;17299.48101556905;16777.83222167763;16870.072146032086;16920.15399230009;17174.141292935554;17405.390811321544;11508.712282193012;11546.711332216426;11660.358680272666;11765.705857353634;11768.293902365886;12487.438065287266;12518.812217816558;12591.307478088793;12671.366431678563;12682.492700291885;9926.801463970825;10038.146757525692;10088.949555252177;10336.793264134825;10573.735656608646;10290.639827605997;10306.793864122825;10359.119474844421;10362.326448780805;10496.632617858339;9061.77345566366;9235.861462077939;9241.861372079558;9253.814923701622;9279.257659387098;6686.364795344434;6823.795286141423;7020.7542736006035;7158.749443769651;7320.158181808947;6594.70323835419;6881.552699074544;6935.271796461299;6958.652067396509;7183.317584829433 21:17:09 INFO - PID 4761 | |4;prototype.html;467.15911359552837;492.8767808047988;493.65268149946996;501.16055606858504;501.8996200759849;6210.596311239767;6257.030160325151;6265.279492858323;6266.1540692006565;6301.968490157543;5926.5258779297665;6077;6080.14877917092;6138.508919286458;6140.877182456359;4729.4797572267025;4730.716157030572;4803.639727020487;4814.374131362918;4818.879528011793;4797.59220466259;4797.760111994404;4799.928001079969;4807.687500312486;4820.855374338758;4755.619550435957;4766.211766116826;4780.593649539794;4785.880352991186;4790.784414701347;4781.37842080529;4786.808527658872;4818.156822556074;4823.454760750846;4831.806727730886;4282.657387409;4288.614024737789;4294.914101717979;4313.547077556843;4361.105973275503;6079.20970273866;6107.694615269219;6138.7237574309265;6144.5698801083945;6169.96915015422;5708.058170401879;5716.514096301819;5750.108733146369;5770.711464426804;5771.913421298684;6586.27550969393;6612.305707900649;6612.93387066128;6630.63531505767;6651.66741662915;4845.370101886732;4863.148948933957;4867.951320486785;4878.536539028786;4887.364642596475;6488.578242414275;6810.421114205298;6854;6855.451563874928;6939.722411103549;4964.404271487445;5000.524845170683;5006.549410553068;5006.924896126561;5007.524285192901;4986.601071914238;4986.975065124651;5027.994401119718;5064.290999260106;5066.847994560169;5462.481064298965;5592.539282715592;5602.411746766531;5649.519790817744;5658.490735833712;6555.672216389162;6557.868842623121;6576.934230657728;6590.901136482957;6606.240282367589;1713.885974116834;1736.8797125853753;1737.556922984656;1746.986747686339;1748.7901451825608;1173.3487914207526;1228.0482625964771;1239.4422509870415;1240.6526172671665;1242.2546472116658;6184.6598437086395;6193.907091393633;6228;6270.372962703693;6281.403266689657;6641.933580664131;6658.600483970978;6677.165354330708;6690.163729533809;6691.698873550702;6186.659733714599;6191.628502289877;6200.627962322275;6202.255729312421;6210.285817130997;3532.8586856525967;3540.610532841437;3543.574771027493;3551.5738111426795;3558.7722235828596;6907.930920690829;6982.1272340957385;6992.650367481708;6994.545354551938;6998.097691766094;6881.931180688229;6923.134608173978;6959.478039147084;6970.233274339818;6990.370866622028;6913;6986.196587392414;7004.894926576106;7018.9298107019295;7026.297370263035;6651.966740166268;6675.666216689049;6686.465082793462;6708.832279192864;6715.294894036056;6267.811965641038;6653.767118150841;6661.666916654245;6706.6646667665445;6721.748214348053;6892.104026476526;6920.238773734985;6931.237563868071;6962.547434416747;6991.615461149686;4962.950370496394;4973.254011898244;4982.925256121233;4988.72562009093;4993.076280888047;6490.448311893542;6746.628935408599;6750.223724271772;6792.830179245559;6795.660216989032;6540.411362977355;6557.311482294291;6559.6064236145985;6598.637074960731;6605.207375115017;6537.542372033912;6556.803295901131;6559.375640173762;6561.311062338385;6572.737090516326;6389.808305750835;6492.805215843532;6524.890768569449;6526.454682673666;6534.967325163534;6567.277599464151;6570.507211959027;6586.110875031809;6591.472682185509;6623.304553022056;6391.552591318563;6404.583702059537;6432.678366081771;6435.646039467874;6453.290138084713 21:17:09 INFO - PID 4761 | |5;yui.html;697.8604279144172;710.893365995101;765.6669348833258;845.0662018469591;862.6549380247902;16983;17324.913375433138;17614.119294035278;17614.47156585303;18379.264829406842;16800.495985120466;17134.657306853856;17191.22639481223;17208.999999999967;17240.56898577536;991.4844280973889;1006.9144122749575;1011.3274672342883;1017.0338178730236;1020.6019652335596;946.5125460387906;1004.5931397783909;1004.7638804880847;1006.7030226083286;1010.1161483701761;1052.100454111731;1052.3843551522368;1052.8683914510686;1052.9262951593391;1054.493842955382;1052.9420881851495;1053.7681710023821;1054.3146954479612;1056.1656291529682;1062.0123285344625;770.5607803551977;774.2605811450052;774.3572834547313;775.6897241103547;777.4713195027379;17469.47591572255;17802.10989450522;17826.55433614157;17907;18589.070546472623;18658.90670546652;18759.437216883514;18874.339398121137;18990.810091899042;19173.904130479397;14272.785908211385;14418.351174197187;14427.206503642296;14429;14467.27663616815;3167.2398624330226;3245.399601073785;3255.300110476235;3317.303366293081;3329.6337402885665;105162.94837051608;105713.47143264234;105716.47141764319;107414.46292768564;108138.45930770374;13416.865831341756;13526.391312390966;13696.315184240748;13782.793258101137;14082.577522674335;26501.20496385073;26536.203913882615;27016.72983270142;27179.592306115424;27312.180634580993;7965.123836377994;8003.639836207385;8169.877451838227;8352.749417517363;8364.665413383518;3910.100676844285;3960.9801950990636;4015.859444919414;4023.8591649292134;4025.75845449274;4616.1229366420275;4691.132140554008;4706.3411122442885;4721.575058244705;4785;922.1608336413831;928.9303302252358;938.5213541094091;941.7410212191566;950.3110245072268;650.8763334966342;668.8461653819649;673.5689158938284;680.1022650101917;695.4193248637343;11930.582429615095;12843.550475733491;12957.352132393342;13841;13911.095778774346;668.6122049211446;673.6093066021696;674.7840690978937;684.5071548485083;685.6331862453563;5309.760985970213;5469.288992430958;5660.97169514158;5699.316082070178;5709.229254050733;102927;107960.46019769851;110656;111096.4445177769;111977.44011279891;97555;97649;98964;99251;103486;88552;88975;89843.12287551972;92553.5372323134;92908.07091928994;10048.447335396331;10309.845352319571;10720.624778132727;12379.566715164927;12527.18573292733;38038.61961380351;38809.80595097006;38819;40853.59146408498;40914.590854091075;65090;65191.34808651853;65830.34169658434;66021.66989165024;66407;16538.50384488419;17350;17509.737353939956;17777.2000259986;17875.37436189727;19114.426567203005;19562.90218548898;19883.30408435698;19916.90041549783;20163.59672806565;15318.693626127639;15354.84645153534;15490.148041857807;15523;15840.970336928063;18140.092995350442;18271.26914923388;18487.53781155482;18684;18940.147693353556;15938.521844344688;16198.433054843024;16225.51323460298;16341.264643091326;16797.41209057677;12899.226046437243;13300.800487992881;13500.392482338122;13790.103643263155;13882.16706997543;13660.453581856615;14308.284585770461;14606.488772892897;14665.780013300022;14776.852231477547 21:17:09 INFO - PID 4761 | __end_tp_report 21:17:09 INFO - PID 4761 | __start_cc_report 21:17:09 INFO - PID 4761 | _x_x_mozilla_cycle_collect,332 21:17:09 INFO - PID 4761 | __end_cc_report 21:17:09 INFO - PID 4761 | __startTimestamp1496895429570__endTimestamp 21:17:09 INFO - PID 4761 | 21:17:09 INFO - PID 4761 | ------- Summary: start ------- 21:17:09 INFO - PID 4761 | Number of tests: 6 21:17:09 INFO - PID 4761 | 21:17:09 INFO - PID 4761 | [#0] dojo.html Cycles:165 Average:6015.41 Median:6293.43 stddev:739.51 (11.8%) stddev-sans-first:711.69 21:17:09 INFO - PID 4761 | Values: 3353.8 3394.6 3400.9 3401.9 3410.3 5933.6 6008.8 6014.5 6028.2 6028.5 5977.4 6012.1 6048.4 6057.4 6110.6 4998.1 5262.0 5344.0 5370.0 5389.7 5390.9 5418.8 5442.8 5443.0 5454.2 5241.0 5315.5 5337.0 5367.8 5367.8 5392.5 5394.4 5406.3 5412.4 5418.8 5355.3 5369.8 5374.3 5374.8 5400.8 5867.9 5960.0 5985.1 6038.1 6052.7 6507.8 6531.5 6533.4 6543.3 6549.7 6569.5 6574.7 6579.2 6582.5 6589.5 6020.3 6059.3 6062.6 6123.3 6135.8 6659.1 6683.3 6689.7 6691.0 6710.8 6230.4 6347.5 6373.2 6405.9 6414.5 6507.9 6509.6 6529.8 6532.5 6554.1 6363.8 6377.6 6433.3 6455.7 6487.1 6486.1 6502.7 6519.0 6543.6 6555.2 4934.2 4945.7 4948.5 4952.4 4975.0 4315.0 4392.1 4392.2 4395.6 4398.6 6063.0 6118.4 6143.8 6148.2 6171.0 6582.3 6586.8 6587.2 6588.7 6633.4 6149.2 6170.4 6170.5 6177.4 6182.6 5443.5 5444.0 5468.4 5483.1 5499.9 6768.6 6774.2 6781.5 6783.3 6799.0 6574.7 6584.6 6597.4 6597.9 6618.7 6661.5 6689.4 6727.6 6728.9 6812.7 6420.0 6429.1 6430.5 6464.2 6488.7 6597.6 6610.6 6619.0 6621.9 6624.9 6268.5 6278.0 6325.8 6366.6 6373.8 6343.9 6388.6 6395.0 6398.8 6423.3 6371.8 6373.0 6381.4 6392.6 6393.9 6260.1 6332.1 6351.9 6410.5 6439.8 6247.5 6250.7 6267.8 6293.4 6294.2 21:17:09 INFO - PID 4761 | 21:17:09 INFO - PID 4761 | [#1] ext.html Cycles:180 Average:37516.95 Median:3575.86 stddev:52089.05 (1456.7%) stddev-sans-first:52162.06 21:17:09 INFO - PID 4761 | Values: 762.8 833.7 851.8 1141.9 1144.8 37393.6 38698.4 38732.0 38864.8 38867.8 41615.8 41979.6 41991.4 42145.2 42234.4 7026.3 7105.2 7329.4 7335.4 7343.7 7261.9 7320.2 7332.6 7336.6 7369.5 7323.9 7384.1 7386.6 7401.7 7416.4 7285.2 7348.7 7354.7 7356.3 7372.8 7089.2 7147.2 7174.6 7179.9 7190.7 38450.4 38831.6 38871.4 38948.4 38966.4 3549.2 3559.4 3564.5 3567.5 3584.2 29494.7 29509.9 29586.0 29596.7 29606.3 3645.0 3658.3 3680.1 3691.0 3695.2 154171.0 158539.0 158547.2 196737.0 198650.0 42918.4 42922.1 43029.6 43116.6 43122.8 43849.3 43976.0 56339.4 57409.0 57549.4 15101.9 15393.8 15405.1 15415.2 15446.2 12186.6 12316.3 12316.8 12317.5 12331.5 15142.6 15224.5 15228.8 15292.1 15429.7 5991.7 6009.2 6049.2 6067.9 6147.6 1058.2 1085.2 1089.3 1093.7 1099.2 24863.8 25453.6 25657.0 26105.3 26142.3 1157.5 1169.1 1190.4 1198.0 1210.6 13282.3 13481.6 13890.9 14084.4 14132.3 247060.0 247148.0 247759.0 247991.0 249069.0 53877.0 54073.0 54236.0 54400.5 54457.0 1445.2 1461.3 1485.5 1491.3 1508.7 24244.4 29429.6 30438.8 31006.5 31101.5 52087.7 52313.2 52584.0 52616.5 53023.0 168170.0 168706.0 169790.0 169971.2 170408.0 35933.3 36306.3 36429.8 36491.5 36523.5 43659.0 44662.6 45090.0 45133.8 45400.5 30864.2 31504.8 32603.7 32746.3 34780.3 32361.7 32387.1 32632.8 32667.2 34094.0 37923.2 38632.4 38961.6 39055.0 39117.0 32016.3 32107.7 32157.5 32376.2 32528.8 24899.6 26062.3 26401.2 26612.6 26952.6 21:17:09 INFO - PID 4761 | 21:17:09 INFO - PID 4761 | [#2] jquery.html Cycles:180 Average:34044.95 Median:21603.96 stddev:86591.29 (400.8%) stddev-sans-first:86797.57 21:17:09 INFO - PID 4761 | Values: 501.5 501.6 504.9 521.5 530.3 20663.4 21369.7 21485.2 21491.1 23879.6 24129.0 24732.0 24733.6 24746.5 24789.5 5850.9 5945.3 5978.3 5982.6 5995.7 5883.5 5933.6 5944.6 5951.6 5958.8 5497.5 5717.6 5745.4 5755.8 5766.2 5698.1 5743.7 5747.9 5748.4 5753.1 5305.9 5331.5 5334.1 5339.7 5342.4 28084.3 28204.6 28504.4 28571.3 28671.3 2204.8 2241.9 2242.1 2242.2 2250.7 18049.7 18608.4 18616.1 18641.3 18692.2 2194.5 2218.2 2219.0 2235.1 2252.9 122665.4 124898.0 130106.3 130513.0 130650.3 13890.6 13946.8 14011.9 14183.0 14434.1 21452.7 21523.5 21560.6 21615.1 21679.3 9000.5 9393.3 9417.9 9492.5 9579.2 8577.9 8636.1 8688.2 8749.9 8805.3 8643.2 8850.4 8914.9 8987.4 9195.3 2498.7 2566.8 2569.8 2597.5 2611.1 1026.8 1031.7 1041.0 1069.1 1097.2 21189.8 21345.3 21399.6 21431.0 21803.7 1054.6 1057.1 1074.6 1087.7 1093.6 11330.7 11430.2 11439.7 11577.9 11749.2 507379.0 508091.0 513621.0 530033.0 532035.0 109061.5 110511.0 111180.0 111693.4 112045.0 1071.9 1095.5 1179.1 1200.2 1228.1 20377.3 20779.5 21062.8 21214.6 21592.8 49957.5 50774.5 51374.5 51571.0 52979.0 65240.7 65633.7 65715.7 65956.0 66626.0 11851.0 12138.9 12156.3 12258.1 12310.8 16864.3 17103.1 17619.3 18110.5 18278.2 15585.8 15654.8 15767.1 15821.3 15853.7 13665.6 13917.7 14095.2 14134.4 14155.6 15121.8 15259.0 15305.7 15398.3 15466.1 12000.6 12046.2 12059.2 12059.7 12103.9 14940.6 15096.3 15497.9 15543.5 15557.5 21:17:09 INFO - PID 4761 | 21:17:09 INFO - PID 4761 | [#3] mootools.html Cycles:180 Average:8373.40 Median:2299.33 stddev:5785.66 (251.6%) stddev-sans-first:5777.77 21:17:09 INFO - PID 4761 | Values: 1341.6 1404.4 1404.6 1406.4 1419.6 12970.0 13506.7 13633.3 13700.7 14052.7 13592.6 13632.1 13740.8 13820.8 13827.2 2351.1 2430.2 2441.3 2444.6 2446.2 2299.8 2342.0 2353.4 2354.7 2363.7 2370.2 2383.5 2386.2 2397.6 2402.0 2241.8 2298.9 2312.3 2322.3 2327.7 1995.7 2075.7 2252.6 2254.7 2275.0 13275.9 13380.1 13404.2 13417.9 13419.4 6855.7 7120.9 7125.1 7125.1 7127.5 4045.3 4158.0 4206.6 4243.0 4335.0 1554.3 1556.8 1566.1 1577.1 1591.5 21647.1 21707.9 21906.1 21928.1 21955.9 5512.4 5780.9 5792.6 5803.7 5870.5 15156.2 15218.7 15220.3 15222.8 15276.2 6869.1 7004.9 7007.6 7015.2 7033.1 6417.3 6512.4 6529.5 6566.0 6606.4 4851.7 4990.4 5014.3 5037.5 5052.3 1392.8 1413.6 1419.0 1420.3 1424.1 903.1 932.6 935.1 936.1 940.2 7295.1 7450.2 7525.5 7608.9 7757.2 698.8 735.1 735.4 739.7 742.3 4587.4 4916.5 5242.1 5631.6 5640.2 17956.9 18314.7 18453.0 18538.3 18860.0 18167.7 18260.4 18332.9 18339.2 18552.3 10321.0 10625.1 10635.2 10655.9 10657.4 7681.6 8512.6 8545.7 8719.0 9125.1 16596.0 16799.0 17011.2 17295.3 17299.5 16777.8 16870.1 16920.2 17174.1 17405.4 11508.7 11546.7 11660.4 11765.7 11768.3 12487.4 12518.8 12591.3 12671.4 12682.5 9926.8 10038.1 10088.9 10336.8 10573.7 10290.6 10306.8 10359.1 10362.3 10496.6 9061.8 9235.9 9241.9 9253.8 9279.3 6686.4 6823.8 7020.8 7158.7 7320.2 6594.7 6881.6 6935.3 6958.7 7183.3 21:17:09 INFO - PID 4761 | 21:17:09 INFO - PID 4761 | [#4] prototype.html Cycles:180 Average:5547.83 Median:6206.27 stddev:1600.67 (25.8%) stddev-sans-first:1559.08 21:17:09 INFO - PID 4761 | Values: 467.2 492.9 493.7 501.2 501.9 6210.6 6257.0 6265.3 6266.2 6302.0 5926.5 6077.0 6080.1 6138.5 6140.9 4729.5 4730.7 4803.6 4814.4 4818.9 4797.6 4797.8 4799.9 4807.7 4820.9 4755.6 4766.2 4780.6 4785.9 4790.8 4781.4 4786.8 4818.2 4823.5 4831.8 4282.7 4288.6 4294.9 4313.5 4361.1 6079.2 6107.7 6138.7 6144.6 6170.0 5708.1 5716.5 5750.1 5770.7 5771.9 6586.3 6612.3 6612.9 6630.6 6651.7 4845.4 4863.1 4868.0 4878.5 4887.4 6488.6 6810.4 6854.0 6855.5 6939.7 4964.4 5000.5 5006.5 5006.9 5007.5 4986.6 4987.0 5028.0 5064.3 5066.8 5462.5 5592.5 5602.4 5649.5 5658.5 6555.7 6557.9 6576.9 6590.9 6606.2 1713.9 1736.9 1737.6 1747.0 1748.8 1173.3 1228.0 1239.4 1240.7 1242.3 6184.7 6193.9 6228.0 6270.4 6281.4 6641.9 6658.6 6677.2 6690.2 6691.7 6186.7 6191.6 6200.6 6202.3 6210.3 3532.9 3540.6 3543.6 3551.6 3558.8 6907.9 6982.1 6992.7 6994.5 6998.1 6881.9 6923.1 6959.5 6970.2 6990.4 6913.0 6986.2 7004.9 7018.9 7026.3 6652.0 6675.7 6686.5 6708.8 6715.3 6267.8 6653.8 6661.7 6706.7 6721.7 6892.1 6920.2 6931.2 6962.5 6991.6 4963.0 4973.3 4982.9 4988.7 4993.1 6490.4 6746.6 6750.2 6792.8 6795.7 6540.4 6557.3 6559.6 6598.6 6605.2 6537.5 6556.8 6559.4 6561.3 6572.7 6389.8 6492.8 6524.9 6526.5 6535.0 6567.3 6570.5 6586.1 6591.5 6623.3 6391.6 6404.6 6432.7 6435.6 6453.3 21:17:09 INFO - PID 4761 | 21:17:09 INFO - PID 4761 | [#5] yui.html Cycles:180 Average:22507.89 Median:18538.30 stddev:30687.63 (165.5%) stddev-sans-first:30730.02 21:17:09 INFO - PID 4761 | Values: 697.9 710.9 765.7 845.1 862.7 16983.0 17324.9 17614.1 17614.5 18379.3 16800.5 17134.7 17191.2 17209.0 17240.6 991.5 1006.9 1011.3 1017.0 1020.6 946.5 1004.6 1004.8 1006.7 1010.1 1052.1 1052.4 1052.9 1052.9 1054.5 1052.9 1053.8 1054.3 1056.2 1062.0 770.6 774.3 774.4 775.7 777.5 17469.5 17802.1 17826.6 17907.0 18589.1 18658.9 18759.4 18874.3 18990.8 19173.9 14272.8 14418.4 14427.2 14429.0 14467.3 3167.2 3245.4 3255.3 3317.3 3329.6 105162.9 105713.5 105716.5 107414.5 108138.5 13416.9 13526.4 13696.3 13782.8 14082.6 26501.2 26536.2 27016.7 27179.6 27312.2 7965.1 8003.6 8169.9 8352.7 8364.7 3910.1 3961.0 4015.9 4023.9 4025.8 4616.1 4691.1 4706.3 4721.6 4785.0 922.2 928.9 938.5 941.7 950.3 650.9 668.8 673.6 680.1 695.4 11930.6 12843.6 12957.4 13841.0 13911.1 668.6 673.6 674.8 684.5 685.6 5309.8 5469.3 5661.0 5699.3 5709.2 102927.0 107960.5 110656.0 111096.4 111977.4 97555.0 97649.0 98964.0 99251.0 103486.0 88552.0 88975.0 89843.1 92553.5 92908.1 10048.4 10309.8 10720.6 12379.6 12527.2 38038.6 38809.8 38819.0 40853.6 40914.6 65090.0 65191.3 65830.3 66021.7 66407.0 16538.5 17350.0 17509.7 17777.2 17875.4 19114.4 19562.9 19883.3 19916.9 20163.6 15318.7 15354.8 15490.1 15523.0 15841.0 18140.1 18271.3 18487.5 18684.0 18940.1 15938.5 16198.4 16225.5 16341.3 16797.4 12899.2 13300.8 13500.4 13790.1 13882.2 13660.5 14308.3 14606.5 14665.8 14776.9 21:17:09 INFO - PID 4761 | -------- Summary: end -------- 21:17:09 INFO - PID 4761 | 21:17:10 INFO - TEST-INFO | 4761: exit 0 21:17:10 INFO - TEST-OK | dromaeo_css | took 1141044ms 21:17:10 INFO - TEST-START | kraken 21:17:10 INFO - operating with platform_type : linux_ 21:17:10 INFO - Initialising browser for kraken test... 21:17:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57708/getInfo.html -profile /tmp/tmpR5A9MP/profile 21:17:10 INFO - TEST-INFO | started process 5189 (/builds/slave/test/build/application/firefox/firefox http://localhost:57708/getInfo.html) 21:17:45 INFO - TEST-INFO | 5189: killed by SIGTERM 21:17:45 INFO - Browser initialized. 21:17:45 INFO - Running cycle 1/1 for kraken test... 21:17:45 INFO - TEST-INFO | started process 5397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR5A9MP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:17:57 INFO - PID 5397 | RSS: Main: 177348608 21:17:57 INFO - PID 5397 | 21:17:59 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57708/tests/kraken/driver.html?testName=audio-beat-detection) 21:18:00 INFO - PID 5397 | RSS: Main: 182898688 21:18:00 INFO - PID 5397 | 21:18:03 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57708/tests/kraken/driver.html?testName=audio-dft) 21:18:03 INFO - PID 5397 | RSS: Main: 180826112 21:18:03 INFO - PID 5397 | 21:18:06 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57708/tests/kraken/driver.html?testName=audio-fft) 21:18:07 INFO - PID 5397 | RSS: Main: 176750592 21:18:07 INFO - PID 5397 | 21:18:09 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57708/tests/kraken/driver.html?testName=audio-oscillator) 21:18:09 INFO - PID 5397 | RSS: Main: 177836032 21:18:09 INFO - PID 5397 | 21:18:12 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57708/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:18:12 INFO - PID 5397 | RSS: Main: 177659904 21:18:12 INFO - PID 5397 | 21:18:15 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57708/tests/kraken/driver.html?testName=imaging-darkroom) 21:18:16 INFO - PID 5397 | RSS: Main: 178884608 21:18:16 INFO - PID 5397 | 21:18:19 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57708/tests/kraken/driver.html?testName=imaging-desaturate) 21:18:20 INFO - PID 5397 | RSS: Main: 177999872 21:18:20 INFO - PID 5397 | 21:18:23 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57708/tests/kraken/driver.html?testName=json-parse-financial) 21:18:23 INFO - PID 5397 | RSS: Main: 178696192 21:18:23 INFO - PID 5397 | 21:18:25 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57708/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:18:25 INFO - PID 5397 | RSS: Main: 178753536 21:18:25 INFO - PID 5397 | 21:18:27 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57708/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:18:28 INFO - PID 5397 | RSS: Main: 179548160 21:18:28 INFO - PID 5397 | 21:18:30 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57708/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:18:31 INFO - PID 5397 | RSS: Main: 179212288 21:18:31 INFO - PID 5397 | 21:18:33 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:18:34 INFO - PID 5397 | RSS: Main: 178995200 21:18:34 INFO - PID 5397 | 21:18:37 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:18:37 INFO - PID 5397 | RSS: Main: 179216384 21:18:37 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | Cycle 1(1): loaded http://localhost:57708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57708/tests/kraken/driver.html?testName=ai-astar) 21:18:39 INFO - PID 5397 | RSS: Main: 180891648 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | __start_tp_report 21:18:39 INFO - PID 5397 | _x_x_mozilla_page_load 21:18:39 INFO - PID 5397 | _x_x_mozilla_page_load_details 21:18:39 INFO - PID 5397 | |i|pagename|runs| 21:18:39 INFO - PID 5397 | |0;ai-astar;99;110;101;110;108;110;108;98;110;108 21:18:39 INFO - PID 5397 | |1;audio-beat-detection;147;117;142;178;120;147;149;123;164;118 21:18:39 INFO - PID 5397 | |2;audio-dft;164;164;162;163;165;164;165;170;175;161 21:18:39 INFO - PID 5397 | |3;audio-fft;73;73;75;171;75;73;73;75;158;74 21:18:39 INFO - PID 5397 | |4;audio-oscillator;83;81;138;82;81;82;137;83;83;132 21:18:39 INFO - PID 5397 | |5;imaging-gaussian-blur;114;115;114;114;113;113;114;113;114;114 21:18:39 INFO - PID 5397 | |6;imaging-darkroom;148;149;149;149;149;150;149;149;149;149 21:18:39 INFO - PID 5397 | |7;imaging-desaturate;94;95;95;95;94;100;94;95;99;99 21:18:39 INFO - PID 5397 | |8;json-parse-financial;48;48;46;47;47;47;52;47;48;47 21:18:39 INFO - PID 5397 | |9;json-stringify-tinderbox;56;54;54;56;54;55;55;56;55;55 21:18:39 INFO - PID 5397 | |10;stanford-crypto-aes;82;82;81;82;89;83;80;82;101;82 21:18:39 INFO - PID 5397 | |11;stanford-crypto-ccm;128;123;124;125;122;124;130;122;121;135 21:18:39 INFO - PID 5397 | |12;stanford-crypto-pbkdf2;176;178;172;174;175;170;172;173;170;171 21:18:39 INFO - PID 5397 | |13;stanford-crypto-sha256-iterative;65;62;70;61;63;64;64;62;62;66 21:18:39 INFO - PID 5397 | __end_tp_report 21:18:39 INFO - PID 5397 | __start_cc_report 21:18:39 INFO - PID 5397 | _x_x_mozilla_cycle_collect,873 21:18:39 INFO - PID 5397 | __end_cc_report 21:18:39 INFO - PID 5397 | __startTimestamp1496895519662__endTimestamp 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | ------- Summary: start ------- 21:18:39 INFO - PID 5397 | Number of tests: 14 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#0] ai-astar Cycles:10 Average:106.20 Median:110.00 stddev:4.87 (4.4%) stddev-sans-first:4.42 21:18:39 INFO - PID 5397 | Values: 99.0 110.0 101.0 110.0 108.0 110.0 108.0 98.0 110.0 108.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:147.00 stddev:20.82 (14.2%) stddev-sans-first:21.95 21:18:39 INFO - PID 5397 | Values: 147.0 117.0 142.0 178.0 120.0 147.0 149.0 123.0 164.0 118.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:4.16 (2.5%) stddev-sans-first:4.39 21:18:39 INFO - PID 5397 | Values: 164.0 164.0 162.0 163.0 165.0 164.0 165.0 170.0 175.0 161.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#3] audio-fft Cycles:10 Average:92.00 Median:73.50 stddev:38.34 (52.2%) stddev-sans-first:40.05 21:18:39 INFO - PID 5397 | Values: 73.0 73.0 75.0 171.0 75.0 73.0 73.0 75.0 158.0 74.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:82.00 stddev:25.91 (31.6%) stddev-sans-first:26.89 21:18:39 INFO - PID 5397 | Values: 83.0 81.0 138.0 82.0 81.0 82.0 137.0 83.0 83.0 132.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 21:18:39 INFO - PID 5397 | Values: 114.0 115.0 114.0 114.0 113.0 113.0 114.0 113.0 114.0 114.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 21:18:39 INFO - PID 5397 | Values: 148.0 149.0 149.0 149.0 149.0 150.0 149.0 149.0 149.0 149.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.00 stddev:2.36 (2.5%) stddev-sans-first:2.39 21:18:39 INFO - PID 5397 | Values: 94.0 95.0 95.0 95.0 94.0 100.0 94.0 95.0 99.0 99.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#8] json-parse-financial Cycles:10 Average:47.70 Median:47.50 stddev:1.64 (3.4%) stddev-sans-first:1.73 21:18:39 INFO - PID 5397 | Values: 48.0 48.0 46.0 47.0 47.0 47.0 52.0 47.0 48.0 47.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.00 stddev:0.82 (1.5%) stddev-sans-first:0.78 21:18:39 INFO - PID 5397 | Values: 56.0 54.0 54.0 56.0 54.0 55.0 55.0 56.0 55.0 55.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:82.00 stddev:6.31 (7.7%) stddev-sans-first:6.63 21:18:39 INFO - PID 5397 | Values: 82.0 82.0 81.0 82.0 89.0 83.0 80.0 82.0 101.0 82.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:124.50 stddev:4.38 (3.5%) stddev-sans-first:4.54 21:18:39 INFO - PID 5397 | Values: 128.0 123.0 124.0 125.0 122.0 124.0 130.0 122.0 121.0 135.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:173.50 stddev:2.64 (1.5%) stddev-sans-first:2.59 21:18:39 INFO - PID 5397 | Values: 176.0 178.0 172.0 174.0 175.0 170.0 172.0 173.0 170.0 171.0 21:18:39 INFO - PID 5397 | 21:18:39 INFO - PID 5397 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:2.64 (4.1%) stddev-sans-first:2.77 21:18:39 INFO - PID 5397 | Values: 65.0 62.0 70.0 61.0 63.0 64.0 64.0 62.0 62.0 66.0 21:18:39 INFO - PID 5397 | -------- Summary: end -------- 21:18:39 INFO - PID 5397 | 21:18:40 INFO - TEST-INFO | 5397: exit 0 21:18:40 INFO - TEST-OK | kraken | took 90356ms 21:18:40 INFO - SUITE-END | took 1231s 21:18:40 INFO - Completed test suite (00:20:31) 21:18:40 INFO - javascript benchmark 21:18:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8205.58000956062, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.8323083845808, 3394.5587073680435, 3400.931981360373, 3401.9489707654407, 3410.317936412718, 5933.643981361121, 6008.759649614016, 6014.458698717114, 6028.186194863692, 6028.517718582509, 5977.372375900533, 6012.098185272201, 6048.425399587032, 6057.42454466825, 6110.602810817294, 4998.125328067592, 5262.0, 5343.973280133594, 5369.973150134244, 5389.703566303851, 5390.9191362129595, 5418.783248670048, 5442.755076021588, 5443.047466693313, 5454.236406903036, 5240.973795131038, 5315.548178404821, 5336.9733151334385, 5367.785288588452, 5367.812126575571, 5392.487713667196, 5394.379646340682, 5406.270153529263, 5412.377576578704, 5418.756155972991, 5355.303810504648, 5369.785208591652, 5374.274472946141, 5374.758135883855, 5400.756965936543, 5867.8533036674, 5960.046392577166, 5985.132155837379, 6038.124471951586, 6052.72762725674, 6507.837304067436, 6531.510136739716, 6533.379328963741, 6543.345665433466, 6549.738010479623, 6569.540132190748, 6574.671266436659, 6579.17760279965, 6582.473402127818, 6589.472842172662, 6020.277566692025, 6059.303180134341, 6062.636241825505, 6123.265208175003, 6135.815925522242, 6659.067730517731, 6683.298253683293, 6689.665516724144, 6690.96654516734, 6710.765123220762, 6230.408111229426, 6347.492200623939, 6373.203349581302, 6405.871882562323, 6414.454771344394, 6507.9023814642815, 6509.609423434609, 6529.804105876831, 6532.510061745293, 6554.082428460019, 6363.7772677956045, 6377.585456945284, 6433.260175079926, 6455.677216139175, 6487.091807147003, 6486.059521369375, 6502.6748662567625, 6518.967405163039, 6543.574667646588, 6555.2133743951035, 4934.1611925972675, 4945.727984960861, 4948.505149485023, 4952.380952380952, 4975.0, 4315.0, 4392.05570802279, 4392.2094023075515, 4395.604395604411, 4398.604125628709, 6063.0, 6118.388161183846, 6143.757528502154, 6148.200733904564, 6171.0, 6582.341765823475, 6586.80239592813, 6587.176602924635, 6588.703508342041, 6633.436157926534, 6149.200603921461, 6170.444659980623, 6170.50635949123, 6177.351378105324, 6182.629042257479, 5443.482869127427, 5444.0, 5468.371137319259, 5483.095289277305, 5499.917501237484, 6768.593884366954, 6774.187097548326, 6781.4574834013165, 6783.321667833177, 6798.966005170041, 6574.671266436563, 6584.604923704593, 6597.373249541286, 6597.934020659732, 6618.702158402787, 6661.467082633475, 6689.364510371507, 6727.596344219362, 6728.932710672831, 6812.727490900506, 6420.0, 6429.067785171217, 6430.453411460078, 6464.191976003, 6488.740450382121, 6597.571157874723, 6610.603363798187, 6619.0, 6621.900671490028, 6624.867502650017, 6268.52986026059, 6277.96861015692, 6325.841853953688, 6366.586171898812, 6373.776917807854, 6343.873122537616, 6388.616682999035, 6395.0, 6398.840028999126, 6423.261324947691, 6371.840703982438, 6372.968135159294, 6381.361863813581, 6392.648404337806, 6393.8721225576155, 6260.060990851409, 6332.11350410952, 6351.872962540631, 6410.45511131559, 6439.774607888701, 6247.531435142473, 6250.718717657625, 6267.811965641038, 6293.4335909766505, 6294.244690637152], "value": 5961.3065504724445, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.843617058503, 833.6582001379434, 851.8296340731852, 1141.9486123124464, 1144.8111061674824, 37393.62606373936, 38698.41952370713, 38732.0316992075, 38864.805675971584, 38867.805660971724, 41615.79192104043, 41979.58020419795, 41991.370129448085, 42145.15709685804, 42234.36648450276, 7026.332498412656, 7105.218425973138, 7329.413646908234, 7335.4498412619005, 7343.669534870917, 7261.927380726178, 7320.158181809107, 7332.560046397233, 7336.559806411606, 7369.4841361104745, 7323.8535229295385, 7384.076990376203, 7386.593737344444, 7401.70393184272, 7416.369608583277, 7285.162206346232, 7348.669309881041, 7354.7425840095875, 7356.264373562654, 7372.815679607999, 7089.184743754483, 7147.249538798404, 7174.605396703179, 7179.89230161548, 7190.712371505134, 38450.42324365137, 38831.61168388336, 38871.41692874609, 38948.415773763416, 38966.415503767465, 3549.165946002687, 3559.430491121434, 3564.518789963374, 3567.518385018015, 3584.193556449778, 29494.705052949626, 29509.852450737824, 29586.0, 29596.70403295961, 29606.25984350387, 3644.9817750911343, 3658.304922064826, 3680.1351682354625, 3690.9630903690886, 3695.2055308108884, 154171.0, 158539.0, 158547.20726396408, 196737.0, 198650.0, 42918.35622465666, 42922.14155716868, 43029.56970430256, 43116.568834311256, 43122.78438607787, 43849.34225986613, 43976.0, 56339.43660563424, 57409.0, 57549.41027653766, 15101.924490377698, 15393.769093463607, 15405.075695458308, 15415.152166630944, 15446.150461724714, 12186.634400967809, 12316.261024338568, 12316.81524777129, 12317.50729970809, 12331.50673973031, 15142.621434464227, 15224.467143650141, 15228.771568426482, 15292.08247505131, 15429.691406172038, 5991.670458124758, 6009.1587177795145, 6049.18336024631, 6067.878642427127, 6147.569670123048, 1058.2327812336148, 1085.1806885801327, 1089.2756317049232, 1093.6718984304678, 1099.1920938110482, 24863.751362486142, 25453.61819572708, 25657.0, 26105.347366315993, 26142.34644133912, 1157.4617802721607, 1169.0647482014353, 1190.4285942747356, 1197.9940100299443, 1210.6368089573093, 13282.3358832058, 13481.59555213345, 13890.861091389159, 14084.366203520865, 14132.293385330693, 247060.0, 247148.0, 247759.0, 247991.0, 249069.0, 53877.0, 54073.0, 54236.0, 54400.45599544033, 54457.0, 1445.2340259662185, 1461.262062658372, 1485.4578079001303, 1491.2543728135931, 1508.7058023685495, 24244.393890152183, 29429.558556622094, 30438.847805761714, 31006.53490197694, 31101.53347699741, 52087.739561301954, 52313.21530176974, 52584.0, 52616.47383526116, 53023.0, 168170.0, 168706.0, 169790.0, 169971.15014424847, 170408.0, 35933.281334372645, 36306.27387452289, 36429.81785091058, 36491.452628211126, 36523.452148217264, 43659.0, 44662.55337446714, 45090.0, 45133.77433112814, 45400.54599454095, 30864.228394290323, 31504.842475787475, 32603.673963260062, 32746.34507309888, 34780.304393912484, 32361.676383235867, 32387.05677659348, 32632.83683581567, 32667.183320417178, 34094.0, 37923.24153516969, 38632.42051369175, 38961.610383896936, 39055.0, 39117.0, 32016.341289223245, 32107.678923211402, 32157.517637234992, 32376.190595235308, 32528.83735581307, 24899.626505602067, 26062.34844128912, 26401.207963761117, 26612.600810987464, 26952.595711064743], "value": 17366.369224507613, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.54610077879533, 501.64633933077187, 504.8561160069381, 521.5149910583156, 530.2867643020138, 20663.38009859703, 21369.67945480817, 21485.248016319394, 21491.140354385807, 23879.641805372932, 24129.03483860648, 24732.0, 24733.628995565083, 24746.505069898638, 24789.50420991579, 5850.853728656775, 5945.256842894638, 5978.252718410199, 5982.611130276518, 5995.670238136922, 5883.47048765611, 5933.6439813611105, 5944.64332140073, 5951.553633477485, 5958.761649534035, 5497.45025497451, 5717.571182161334, 5745.396733343002, 5755.798547050854, 5766.1639062335935, 5698.145278208261, 5743.655380677152, 5747.856303592402, 5748.42515748426, 5753.079507278857, 5305.867353316159, 5331.546818520431, 5334.093204155264, 5339.70631615261, 5342.358916929955, 28084.29789255285, 28204.576931346048, 28504.429911401865, 28571.285717857012, 28671.28321791951, 2204.845660803728, 2241.8542794718455, 2242.0807468937655, 2242.1816037146486, 2250.6849041134255, 18049.7292540612, 18608.44174674762, 18616.069196540255, 18641.25434982599, 18692.158852851655, 2194.517206214646, 2218.223621732397, 2219.04581030157, 2235.117128734157, 2252.876091814966, 122665.38667306607, 124898.0, 130106.349468253, 130513.0, 130650.3467482666, 13890.58328250154, 13946.790798138036, 14011.859881401055, 14183.0, 14434.133951962916, 21452.678209826867, 21523.461913452287, 21560.56878862414, 21615.135394584042, 21679.34961951144, 9000.54997250148, 9393.295502837178, 9417.905820941703, 9492.525373731285, 9579.233661307078, 8577.914220857836, 8636.093210212963, 8688.174623410765, 8749.868751968726, 8805.251553617885, 8643.234165067119, 8850.380473366931, 8914.86627700585, 8987.41581797181, 9195.264378849675, 2498.675172227599, 2566.807489438262, 2569.79441644668, 2597.467519158568, 2611.073069060456, 1026.820306446369, 1031.7008067660445, 1040.9843852342221, 1069.0699091790193, 1097.237419993113, 21189.78810211909, 21345.25291614786, 21399.572008559742, 21431.0, 21803.67294490584, 1054.6256079091966, 1057.1120258982492, 1074.5701719312337, 1087.7335052911928, 1093.573506332531, 11330.660080197607, 11430.1998860079, 11439.656810295704, 11577.942110289394, 11749.177557570887, 507379.0, 508091.0, 513621.0, 530033.0, 532035.0, 109061.45469272761, 110511.0, 111180.0, 111693.44153279344, 112045.0, 1071.914246860265, 1095.4905968724422, 1179.0862081886607, 1200.237848965913, 1228.0605336917088, 20377.286794962107, 20779.48051298669, 21062.789372106698, 21214.6451674043, 21592.784072159706, 49957.50042499528, 50774.49225507698, 51374.48625513697, 51571.0, 52979.0, 65240.67379663261, 65633.67183164053, 65715.67142164259, 65956.0, 66626.0, 11851.0, 12138.939305303416, 12156.270623762603, 12258.080643951562, 12310.815337769762, 16864.325426983272, 17103.14484275806, 17619.29522819124, 18110.5472363192, 18278.177482013074, 15585.844141558438, 15654.765178522104, 15767.053976761432, 15821.288042038366, 15853.682926341638, 13665.590032299047, 13917.721645567235, 14095.224762637743, 14134.363953621905, 14155.64610884736, 15121.848781512044, 15259.0, 15305.693886121993, 15398.307076181374, 15466.072035677895, 12000.57997970067, 12046.216995895238, 12059.21615095016, 12059.733727958437, 12103.878961210627, 14940.626484337978, 15096.320665569856, 15497.922510387376, 15543.45597904068, 15557.533274001798], "value": 11184.835876457913, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.6444642169824, 1404.4452441285687, 1404.6207523968528, 1406.4163372200537, 1419.5741277616712, 12970.0, 13506.662333441669, 13633.318334083293, 13700.657483562916, 14052.718945621107, 13592.592222233348, 13632.113912595674, 13740.79388809166, 13820.792688109661, 13827.23950182742, 2351.059576169533, 2430.2466235467064, 2441.316431399211, 2444.633305004246, 2446.156076153733, 2299.7585253548386, 2341.9648705269433, 2353.364591560278, 2354.693889794324, 2363.6809030780796, 2370.2059809963685, 2383.4637206628545, 2386.152915714922, 2397.5564520563667, 2401.987990060047, 2241.764614715448, 2298.908043678251, 2312.271634435156, 2322.3033090072995, 2327.7439481657, 1995.7405537280206, 2075.740532433446, 2252.6395776675818, 2254.7068881045525, 2274.977250227493, 13275.933620331933, 13380.130291531117, 13404.195748255135, 13417.865821341758, 13419.396127174301, 6855.6572171391235, 7120.857582848365, 7125.1093613298335, 7125.144982602121, 7127.465440091962, 4045.3325201341745, 4158.0, 4206.579342065799, 4243.0, 4334.956650433487, 1554.3394057525506, 1556.8053993250844, 1566.1307974074384, 1577.1483398964544, 1591.5384538483827, 21647.134114635395, 21707.891460542596, 21906.12375504978, 21928.122875084977, 21955.9141881521, 5512.4211957744665, 5780.942190578125, 5792.623479473821, 5803.651780893076, 5870.4716575507555, 15156.24218789056, 15218.695626087416, 15220.315085821165, 15222.771658425132, 15276.236188190545, 6869.141357330333, 7004.859902802017, 7007.649617519103, 7015.193252775894, 7033.085698859218, 6417.262014868256, 6512.413882750575, 6529.54293199481, 6566.0, 6606.372394622503, 4851.684640498427, 4990.426100998359, 5014.2979982802435, 5037.496250374933, 5052.292679024939, 1392.8189335386335, 1413.6041908265497, 1419.0279658434006, 1420.2614640386942, 1424.0530047518284, 903.1420150856712, 932.6316105138433, 935.1350001248818, 936.0592604432638, 940.238406890421, 7295.124585049828, 7450.18048014718, 7525.548467091992, 7608.923910760932, 7757.224277572198, 698.769406095987, 735.1288722863424, 735.4153448008846, 739.7226040234912, 742.2725728785712, 4587.4036375271, 4916.514356756856, 5242.056429842589, 5631.6491687445905, 5640.182173584807, 17956.91021544884, 18314.725279120823, 18453.0, 18538.25846966106, 18860.0, 18167.72748408775, 18260.360887369145, 18332.908335458236, 18339.174737136862, 18552.257909683733, 10321.0, 10625.149988000941, 10635.202359823044, 10655.893441065646, 10657.360558366523, 7681.569816137006, 8512.616932237941, 8545.675420309863, 8719.0, 9125.133112354315, 16596.0, 16799.0, 17011.23449444803, 17295.308187672854, 17299.48101556905, 16777.83222167763, 16870.072146032086, 16920.15399230009, 17174.141292935554, 17405.390811321544, 11508.712282193012, 11546.711332216426, 11660.358680272666, 11765.705857353634, 11768.293902365886, 12487.438065287266, 12518.812217816558, 12591.307478088793, 12671.366431678563, 12682.492700291885, 9926.801463970825, 10038.146757525692, 10088.949555252177, 10336.793264134825, 10573.735656608646, 10290.639827605997, 10306.793864122825, 10359.119474844421, 10362.326448780805, 10496.632617858339, 9061.77345566366, 9235.861462077939, 9241.861372079558, 9253.814923701622, 9279.257659387098, 6686.364795344434, 6823.795286141423, 7020.7542736006035, 7158.749443769651, 7320.158181808947, 6594.70323835419, 6881.552699074544, 6935.271796461299, 6958.652067396509, 7183.317584829433], "value": 6009.79702346613, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.15911359552837, 492.8767808047988, 493.65268149946996, 501.16055606858504, 501.8996200759849, 6210.596311239767, 6257.030160325151, 6265.279492858323, 6266.1540692006565, 6301.968490157543, 5926.5258779297665, 6077.0, 6080.14877917092, 6138.508919286458, 6140.877182456359, 4729.4797572267025, 4730.716157030572, 4803.639727020487, 4814.374131362918, 4818.879528011793, 4797.59220466259, 4797.760111994404, 4799.928001079969, 4807.687500312486, 4820.855374338758, 4755.619550435957, 4766.211766116826, 4780.593649539794, 4785.880352991186, 4790.784414701347, 4781.37842080529, 4786.808527658872, 4818.156822556074, 4823.454760750846, 4831.806727730886, 4282.657387409, 4288.614024737789, 4294.914101717979, 4313.547077556843, 4361.105973275503, 6079.20970273866, 6107.694615269219, 6138.7237574309265, 6144.5698801083945, 6169.96915015422, 5708.058170401879, 5716.514096301819, 5750.108733146369, 5770.711464426804, 5771.913421298684, 6586.27550969393, 6612.305707900649, 6612.93387066128, 6630.63531505767, 6651.66741662915, 4845.370101886732, 4863.148948933957, 4867.951320486785, 4878.536539028786, 4887.364642596475, 6488.578242414275, 6810.421114205298, 6854.0, 6855.451563874928, 6939.722411103549, 4964.404271487445, 5000.524845170683, 5006.549410553068, 5006.924896126561, 5007.524285192901, 4986.601071914238, 4986.975065124651, 5027.994401119718, 5064.290999260106, 5066.847994560169, 5462.481064298965, 5592.539282715592, 5602.411746766531, 5649.519790817744, 5658.490735833712, 6555.672216389162, 6557.868842623121, 6576.934230657728, 6590.901136482957, 6606.240282367589, 1713.885974116834, 1736.8797125853753, 1737.556922984656, 1746.986747686339, 1748.7901451825608, 1173.3487914207526, 1228.0482625964771, 1239.4422509870415, 1240.6526172671665, 1242.2546472116658, 6184.6598437086395, 6193.907091393633, 6228.0, 6270.372962703693, 6281.403266689657, 6641.933580664131, 6658.600483970978, 6677.165354330708, 6690.163729533809, 6691.698873550702, 6186.659733714599, 6191.628502289877, 6200.627962322275, 6202.255729312421, 6210.285817130997, 3532.8586856525967, 3540.610532841437, 3543.574771027493, 3551.5738111426795, 3558.7722235828596, 6907.930920690829, 6982.1272340957385, 6992.650367481708, 6994.545354551938, 6998.097691766094, 6881.931180688229, 6923.134608173978, 6959.478039147084, 6970.233274339818, 6990.370866622028, 6913.0, 6986.196587392414, 7004.894926576106, 7018.9298107019295, 7026.297370263035, 6651.966740166268, 6675.666216689049, 6686.465082793462, 6708.832279192864, 6715.294894036056, 6267.811965641038, 6653.767118150841, 6661.666916654245, 6706.6646667665445, 6721.748214348053, 6892.104026476526, 6920.238773734985, 6931.237563868071, 6962.547434416747, 6991.615461149686, 4962.950370496394, 4973.254011898244, 4982.925256121233, 4988.72562009093, 4993.076280888047, 6490.448311893542, 6746.628935408599, 6750.223724271772, 6792.830179245559, 6795.660216989032, 6540.411362977355, 6557.311482294291, 6559.6064236145985, 6598.637074960731, 6605.207375115017, 6537.542372033912, 6556.803295901131, 6559.375640173762, 6561.311062338385, 6572.737090516326, 6389.808305750835, 6492.805215843532, 6524.890768569449, 6526.454682673666, 6534.967325163534, 6567.277599464151, 6570.507211959027, 6586.110875031809, 6591.472682185509, 6623.304553022056, 6391.552591318563, 6404.583702059537, 6432.678366081771, 6435.646039467874, 6453.290138084713], "value": 5070.945262530297, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.8604279144172, 710.893365995101, 765.6669348833258, 845.0662018469591, 862.6549380247902, 16983.0, 17324.913375433138, 17614.119294035278, 17614.47156585303, 18379.264829406842, 16800.495985120466, 17134.657306853856, 17191.22639481223, 17208.999999999967, 17240.56898577536, 991.4844280973889, 1006.9144122749575, 1011.3274672342883, 1017.0338178730236, 1020.6019652335596, 946.5125460387906, 1004.5931397783909, 1004.7638804880847, 1006.7030226083286, 1010.1161483701761, 1052.100454111731, 1052.3843551522368, 1052.8683914510686, 1052.9262951593391, 1054.493842955382, 1052.9420881851495, 1053.7681710023821, 1054.3146954479612, 1056.1656291529682, 1062.0123285344625, 770.5607803551977, 774.2605811450052, 774.3572834547313, 775.6897241103547, 777.4713195027379, 17469.47591572255, 17802.10989450522, 17826.55433614157, 17907.0, 18589.070546472623, 18658.90670546652, 18759.437216883514, 18874.339398121137, 18990.810091899042, 19173.904130479397, 14272.785908211385, 14418.351174197187, 14427.206503642296, 14429.0, 14467.27663616815, 3167.2398624330226, 3245.399601073785, 3255.300110476235, 3317.303366293081, 3329.6337402885665, 105162.94837051608, 105713.47143264234, 105716.47141764319, 107414.46292768564, 108138.45930770374, 13416.865831341756, 13526.391312390966, 13696.315184240748, 13782.793258101137, 14082.577522674335, 26501.20496385073, 26536.203913882615, 27016.72983270142, 27179.592306115424, 27312.180634580993, 7965.123836377994, 8003.639836207385, 8169.877451838227, 8352.749417517363, 8364.665413383518, 3910.100676844285, 3960.9801950990636, 4015.859444919414, 4023.8591649292134, 4025.75845449274, 4616.1229366420275, 4691.132140554008, 4706.3411122442885, 4721.575058244705, 4785.0, 922.1608336413831, 928.9303302252358, 938.5213541094091, 941.7410212191566, 950.3110245072268, 650.8763334966342, 668.8461653819649, 673.5689158938284, 680.1022650101917, 695.4193248637343, 11930.582429615095, 12843.550475733491, 12957.352132393342, 13841.0, 13911.095778774346, 668.6122049211446, 673.6093066021696, 674.7840690978937, 684.5071548485083, 685.6331862453563, 5309.760985970213, 5469.288992430958, 5660.97169514158, 5699.316082070178, 5709.229254050733, 102927.0, 107960.46019769851, 110656.0, 111096.4445177769, 111977.44011279891, 97555.0, 97649.0, 98964.0, 99251.0, 103486.0, 88552.0, 88975.0, 89843.12287551972, 92553.5372323134, 92908.07091928994, 10048.447335396331, 10309.845352319571, 10720.624778132727, 12379.566715164927, 12527.18573292733, 38038.61961380351, 38809.80595097006, 38819.0, 40853.59146408498, 40914.590854091075, 65090.0, 65191.34808651853, 65830.34169658434, 66021.66989165024, 66407.0, 16538.50384488419, 17350.0, 17509.737353939956, 17777.2000259986, 17875.37436189727, 19114.426567203005, 19562.90218548898, 19883.30408435698, 19916.90041549783, 20163.59672806565, 15318.693626127639, 15354.84645153534, 15490.148041857807, 15523.0, 15840.970336928063, 18140.092995350442, 18271.26914923388, 18487.53781155482, 18684.0, 18940.147693353556, 15938.521844344688, 16198.433054843024, 16225.51323460298, 16341.264643091326, 16797.41209057677, 12899.226046437243, 13300.800487992881, 13500.392482338122, 13790.103643263155, 13882.16706997543, 13660.453581856615, 14308.284585770461, 14606.488772892897, 14665.780013300022, 14776.852231477547], "value": 8649.672002346428, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1510.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 101.0, 110.0, 108.0, 110.0, 108.0, 98.0, 110.0, 108.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 142.0, 178.0, 120.0, 147.0, 149.0, 123.0, 164.0, 118.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 163.0, 165.0, 164.0, 165.0, 170.0, 175.0, 161.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 171.0, 75.0, 73.0, 73.0, 75.0, 158.0, 74.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 138.0, 82.0, 81.0, 82.0, 137.0, 83.0, 83.0, 132.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 149.0, 149.0, 150.0, 149.0, 149.0, 149.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 100.0, 94.0, 95.0, 99.0, 99.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 46.0, 47.0, 47.0, 47.0, 52.0, 47.0, 48.0, 47.0], "value": 47.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 56.0, 54.0, 55.0, 55.0, 56.0, 55.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 82.0, 89.0, 83.0, 80.0, 82.0, 101.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 123.0, 124.0, 125.0, 122.0, 124.0, 130.0, 122.0, 121.0, 135.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 178.0, 172.0, 174.0, 175.0, 170.0, 172.0, 173.0, 170.0, 171.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 70.0, 61.0, 63.0, 64.0, 64.0, 62.0, 62.0, 66.0], "value": 63.9, "unit": "score"}]}]} 21:18:40 INFO - Return code: 0 21:18:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:18:41 INFO - # TBPL SUCCESS # 21:18:41 INFO - Running post-action listener: _resource_record_post_action 21:18:41 INFO - [mozharness: 2017-06-08 04:18:41.029374Z] Finished run-tests step (success) 21:18:41 INFO - Running post-run listener: _resource_record_post_run 21:18:41 INFO - Total resource usage - Wall time: 1248s; CPU: 13.0%; Read bytes: 4096; Write bytes: 414445568; Read time: 20; Write time: 319216 21:18:41 INFO - TinderboxPrint: CPU usage
12.6% 21:18:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 21:18:41 INFO - TinderboxPrint: I/O write bytes / time
414,445,568 / 319,216 21:18:41 INFO - TinderboxPrint: CPU idle
8,708.1 (87.4%) 21:18:41 INFO - TinderboxPrint: CPU user
1,199.2 (12.0%) 21:18:41 INFO - TinderboxPrint: Swap in / out
0 / 0 21:18:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103120896; Read time: 0; Write time: 121756 21:18:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 21:18:41 INFO - run-tests - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 311324672; Read time: 0; Write time: 197460 21:18:41 INFO - Running post-run listener: _upload_blobber_files 21:18:41 INFO - Blob upload gear active. 21:18:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:18:41 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 21:18:41 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'] 21:18:41 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 21:18:42 INFO - (blobuploader) - INFO - Open directory for files ... 21:18:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:18:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:18:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:18:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:18:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:18:45 INFO - (blobuploader) - INFO - Done attempting. 21:18:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:18:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:18:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:18:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:18:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:18:48 INFO - (blobuploader) - INFO - Done attempting. 21:18:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:18:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:18:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:18:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:18:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:18:48 INFO - (blobuploader) - INFO - Done attempting. 21:18:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:18:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:18:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:18:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:18:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:18:49 INFO - (blobuploader) - INFO - Done attempting. 21:18:49 INFO - (blobuploader) - INFO - Iteration through files over. 21:18:49 INFO - Return code: 0 21:18:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:18:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:18:49 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87404ca170781b737a9fefa616e3cbe16228dd929c32f935cf963e0026eca88817884922aca5e300bb7db096616a26baeca1bdcd99633a52e9bd4f6e49006c7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec0257eae8fdfd011e353e937da44e2743aac9eae9bf89c0e5f345ed0ba65f321d9f66839254395c89ba598c4f386c04760bc463a5c8e0a938b46d38a5fe98d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed6e56c38f7f0dff56bbe9df3e5f3d8945ecf5d658a0cbeffbf2bcbbcea725a8d19a39cee1b88f2dcc57113006386662a0f54f618170e74e06744f1b1a7a7e82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2075741caca9709263399ff3b790c81f5eef427eb53da71975e688898fca3c78d0cb0528c75851308a6de99e51ca457990f9016d1f49abe7470c83e51a423618"} 21:18:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:18:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:18:49 INFO - Contents: 21:18:49 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87404ca170781b737a9fefa616e3cbe16228dd929c32f935cf963e0026eca88817884922aca5e300bb7db096616a26baeca1bdcd99633a52e9bd4f6e49006c7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec0257eae8fdfd011e353e937da44e2743aac9eae9bf89c0e5f345ed0ba65f321d9f66839254395c89ba598c4f386c04760bc463a5c8e0a938b46d38a5fe98d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed6e56c38f7f0dff56bbe9df3e5f3d8945ecf5d658a0cbeffbf2bcbbcea725a8d19a39cee1b88f2dcc57113006386662a0f54f618170e74e06744f1b1a7a7e82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2075741caca9709263399ff3b790c81f5eef427eb53da71975e688898fca3c78d0cb0528c75851308a6de99e51ca457990f9016d1f49abe7470c83e51a423618"} 21:18:49 INFO - Running post-run listener: copy_logs_to_upload_dir 21:18:49 INFO - Copying logs to upload dir... 21:18:49 INFO - mkdir: /builds/slave/test/build/upload/logs 21:18:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1307.091197 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2017-06-07 21:18:47.455484) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-07 21:18:47.459391) ========= 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=eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653 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/87404ca170781b737a9fefa616e3cbe16228dd929c32f935cf963e0026eca88817884922aca5e300bb7db096616a26baeca1bdcd99633a52e9bd4f6e49006c7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec0257eae8fdfd011e353e937da44e2743aac9eae9bf89c0e5f345ed0ba65f321d9f66839254395c89ba598c4f386c04760bc463a5c8e0a938b46d38a5fe98d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed6e56c38f7f0dff56bbe9df3e5f3d8945ecf5d658a0cbeffbf2bcbbcea725a8d19a39cee1b88f2dcc57113006386662a0f54f618170e74e06744f1b1a7a7e82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2075741caca9709263399ff3b790c81f5eef427eb53da71975e688898fca3c78d0cb0528c75851308a6de99e51ca457990f9016d1f49abe7470c83e51a423618"} build_url:https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/RhJ5SRXgQxylQauR8wwmQA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87404ca170781b737a9fefa616e3cbe16228dd929c32f935cf963e0026eca88817884922aca5e300bb7db096616a26baeca1bdcd99633a52e9bd4f6e49006c7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec0257eae8fdfd011e353e937da44e2743aac9eae9bf89c0e5f345ed0ba65f321d9f66839254395c89ba598c4f386c04760bc463a5c8e0a938b46d38a5fe98d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed6e56c38f7f0dff56bbe9df3e5f3d8945ecf5d658a0cbeffbf2bcbbcea725a8d19a39cee1b88f2dcc57113006386662a0f54f618170e74e06744f1b1a7a7e82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2075741caca9709263399ff3b790c81f5eef427eb53da71975e688898fca3c78d0cb0528c75851308a6de99e51ca457990f9016d1f49abe7470c83e51a423618"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-07 21:18:47.486313) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 21:18:47.486632) ========= 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=eca2ab57546de7b41f256b19000001ef-1496890379.138704-872125653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 21:18:47.569652) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-07 21:18:47.572988) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-07 21:18:47.573316) ========= ========= Total master_lag: 0.19 =========