builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1496506736.22 results: success (0) revision: 98f1390029f9bd558de991a53c92342ac0addfc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:56.217995) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:56.218432) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:56.218708) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:56.242200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:56.242449) ========= 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-1496506233.647208-347624966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-03 09:18:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-06-03 09:18:56 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:56.373540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:56.376885) ========= 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-1496506233.647208-347624966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018362 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:56.427254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:56.427555) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 98f1390029f9bd558de991a53c92342ac0addfc4 --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 98f1390029f9bd558de991a53c92342ac0addfc4 --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-1496506233.647208-347624966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-03 09:18:56,412 truncating revision to first 12 chars 2017-06-03 09:18:56,412 Setting DEBUG logging. 2017-06-03 09:18:56,412 attempt 1/10 2017-06-03 09:18:56,412 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/98f1390029f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-03 09:18:56,870 unpacking tar archive at: mozilla-central-98f1390029f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.793526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:57.237392) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:57.237666) ========= script_repo_revision: 98f1390029f9bd558de991a53c92342ac0addfc4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:57.238035) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:57.238296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-03 09:18:57.251606) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-06-03 09:18:57.251874) ========= /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-1496506233.647208-347624966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:18:57 INFO - MultiFileLogger online at 20170603 09:18:57 in /builds/slave/test 09:18:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:18:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:18:57 INFO - {'append_to_log': False, 09:18:57 INFO - 'base_work_dir': '/builds/slave/test', 09:18:57 INFO - 'blob_upload_branch': 'Firefox', 09:18:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:18:57 INFO - 'branch': 'Firefox', 09:18:57 INFO - 'buildbot_json_path': 'buildprops.json', 09:18:57 INFO - 'config_files': ('talos/linux_config.py',), 09:18:57 INFO - 'default_actions': ('clobber', 09:18:57 INFO - 'read-buildbot-config', 09:18:57 INFO - 'download-and-extract', 09:18:57 INFO - 'populate-webroot', 09:18:57 INFO - 'create-virtualenv', 09:18:57 INFO - 'install', 09:18:57 INFO - 'setup-mitmproxy', 09:18:57 INFO - 'run-tests'), 09:18:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:18:57 INFO - 'download_minidump_stackwalk': True, 09:18:57 INFO - 'download_symbols': 'ondemand', 09:18:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:18:57 INFO - 'tooltool.py': '/tools/tooltool.py', 09:18:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:18:57 INFO - '/tools/misc-python/virtualenv.py')}, 09:18:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:18:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:18:57 INFO - 'gecko_profile': False, 09:18:57 INFO - 'gecko_profile_interval': 0, 09:18:57 INFO - 'installer_path': 'installer.exe', 09:18:57 INFO - 'log_level': 'info', 09:18:57 INFO - 'log_name': 'talos', 09:18:57 INFO - 'log_to_console': True, 09:18:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:18:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:18:57 INFO - 'opt_config_files': (), 09:18:57 INFO - 'pip_index': False, 09:18:57 INFO - 'suite': 'dromaeojs-e10s', 09:18:57 INFO - 'system_bits': '32', 09:18:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:18:57 INFO - 'title': 'talos-linux64-ix-010', 09:18:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:18:57 INFO - 'use_talos_json': True, 09:18:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:18:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:18:57 INFO - 'work_dir': 'build'} 09:18:57 INFO - [mozharness: 2017-06-03 16:18:57.339863Z] Running clobber step. 09:18:57 INFO - Running pre-action listener: _resource_record_pre_action 09:18:57 INFO - Running main action method: clobber 09:18:57 INFO - rmtree: /builds/slave/test/build 09:18:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:18:58 INFO - Running post-action listener: _resource_record_post_action 09:18:58 INFO - [mozharness: 2017-06-03 16:18:58.869652Z] Finished clobber step (success) 09:18:58 INFO - [mozharness: 2017-06-03 16:18:58.869751Z] Running read-buildbot-config step. 09:18:58 INFO - Running pre-action listener: _resource_record_pre_action 09:18:58 INFO - Running main action method: read_buildbot_config 09:18:58 INFO - Using buildbot properties: 09:18:58 INFO - { 09:18:58 INFO - "project": "", 09:18:58 INFO - "product": "firefox", 09:18:58 INFO - "who": "ffxbld@noreply.mozilla.org", 09:18:58 INFO - "installer_path": "public/build/target.tar.bz2", 09:18:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 09:18:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:18:58 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 09:18:58 INFO - "stage_platform": "linux64-stylosequential", 09:18:58 INFO - "basedir": "/builds/slave/test", 09:18:58 INFO - "buildnumber": 48, 09:18:58 INFO - "platform": "ubuntu64_hw_styloseq", 09:18:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:18:58 INFO - "slavebuilddir": "test", 09:18:58 INFO - "taskId": "KB50TByiQ92t1aD5pBJyCA", 09:18:58 INFO - "branch": "mozilla-central", 09:18:58 INFO - "script_repo_revision": "production", 09:18:58 INFO - "revision": "98f1390029f9bd558de991a53c92342ac0addfc4", 09:18:58 INFO - "slavename": "talos-linux64-ix-010", 09:18:58 INFO - "repo_path": "mozilla-central" 09:18:58 INFO - } 09:18:58 INFO - Finding installer, test and symbols from parent task. 09:18:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KB50TByiQ92t1aD5pBJyCA'}, attempt #1 09:18:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KB50TByiQ92t1aD5pBJyCA'}, attempt #1 09:18:59 INFO - Task dependencies: UGE2iFDrT826tnCCpYLODA 09:18:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA'}, attempt #1 09:19:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.tar.bz2 09:19:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/test_packages.json 09:19:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.crashreporter-symbols.zip 09:19:00 INFO - Running post-action listener: _resource_record_post_action 09:19:00 INFO - [mozharness: 2017-06-03 16:19:00.211715Z] Finished read-buildbot-config step (success) 09:19:00 INFO - [mozharness: 2017-06-03 16:19:00.211934Z] Running download-and-extract step. 09:19:00 INFO - Running pre-action listener: _resource_record_pre_action 09:19:00 INFO - Running main action method: download_and_extract 09:19:00 INFO - mkdir: /builds/slave/test/build/tests 09:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:00 INFO - trying https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.test_packages.json 09:19:00 INFO - Downloading https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:19:00 INFO - Downloaded 989 bytes. 09:19:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:19:00 INFO - Using the following test package requirements: 09:19:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:19:00 INFO - u'common': [u'target.common.tests.zip'], 09:19:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:19:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:19:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:19:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:19:00 INFO - u'mozbase': [u'target.common.tests.zip'], 09:19:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:19:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:19:00 INFO - u'web-platform': [u'target.common.tests.zip', 09:19:00 INFO - u'target.web-platform.tests.tar.gz'], 09:19:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:19:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:19:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.common.tests.zip 09:19:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:19:00 INFO - Fetch https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.common.tests.zip into memory 09:19:03 INFO - Content-Length response header: 65108291 09:19:03 INFO - Bytes received: 65108291 09:19:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:19:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.common.tests.zip 09:19:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:19:14 INFO - Fetch https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.common.tests.zip into memory 09:19:17 INFO - Content-Length response header: 65108291 09:19:17 INFO - Bytes received: 65108291 09:19:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.talos.tests.zip 09:19:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:19:31 INFO - Fetch https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.talos.tests.zip into memory 09:19:31 INFO - Content-Length response header: 14447425 09:19:31 INFO - Bytes received: 14447425 09:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:32 INFO - trying https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.tar.bz2 09:19:32 INFO - Downloading https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:19:33 INFO - Downloaded 60386691 bytes. 09:19:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.tar.bz2 09:19:33 INFO - mkdir: /builds/slave/test/properties 09:19:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:33 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:33 INFO - Contents: 09:19:33 INFO - build_url:https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.tar.bz2 09:19:33 INFO - Running post-action listener: _resource_record_post_action 09:19:33 INFO - Running post-action listener: set_extra_try_arguments 09:19:33 INFO - [mozharness: 2017-06-03 16:19:33.556108Z] Finished download-and-extract step (success) 09:19:33 INFO - [mozharness: 2017-06-03 16:19:33.556204Z] Running populate-webroot step. 09:19:33 INFO - Running pre-action listener: _resource_record_pre_action 09:19:33 INFO - Running main action method: populate_webroot 09:19:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:33 INFO - '--tppagecycles', 09:19:33 INFO - '7'], 09:19:33 INFO - 'tests': ['tsvgm']}}, 09:19:33 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:19:33 INFO - 'talos_options': ['--disable-e10s'], 09:19:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:19:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:19:33 INFO - 'talos_options': ['--disable-e10s'], 09:19:33 INFO - 'tests': ['damp', 'tps']}, 09:19:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:19:33 INFO - 'tests': ['damp', 'tps']}, 09:19:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:33 INFO - 'tests': ['dromaeo_dom']}, 09:19:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:33 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:19:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:19:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:19:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:19:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:33 INFO - 'tests': ['a11yr', 09:19:33 INFO - 'ts_paint', 09:19:33 INFO - 'tpaint', 09:19:33 INFO - 'sessionrestore', 09:19:33 INFO - 'sessionrestore_no_auto_restore', 09:19:33 INFO - 'tabpaint']}, 09:19:33 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:33 INFO - 'ts_paint', 09:19:33 INFO - 'tpaint', 09:19:33 INFO - 'sessionrestore', 09:19:33 INFO - 'sessionrestore_no_auto_restore', 09:19:33 INFO - 'tabpaint']}, 09:19:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:33 INFO - 'ts_paint', 09:19:33 INFO - 'tpaint', 09:19:33 INFO - 'sessionrestore', 09:19:33 INFO - 'sessionrestore_no_auto_restore', 09:19:33 INFO - 'tabpaint']}, 09:19:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:33 INFO - 'ts_paint', 09:19:33 INFO - 'tpaint', 09:19:33 INFO - 'sessionrestore', 09:19:33 INFO - 'sessionrestore_no_auto_restore', 09:19:33 INFO - 'tabpaint']}, 09:19:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:33 INFO - 'tests': ['a11yr', 09:19:33 INFO - 'ts_paint', 09:19:33 INFO - 'tpaint', 09:19:33 INFO - 'sessionrestore', 09:19:33 INFO - 'sessionrestore_no_auto_restore', 09:19:33 INFO - 'tabpaint']}, 09:19:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:33 INFO - 'tests': ['a11yr', 09:19:33 INFO - 'ts_paint', 09:19:33 INFO - 'tpaint', 09:19:33 INFO - 'sessionrestore', 09:19:33 INFO - 'sessionrestore_no_auto_restore', 09:19:33 INFO - 'tabpaint']}, 09:19:33 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:19:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:19:33 INFO - 'bloom_basic_ref']}, 09:19:33 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:19:33 INFO - 'talos_options': ['--mitmproxy', 09:19:33 INFO - 'mitmproxy-recording-1.mp', 09:19:33 INFO - '--firstNonBlankPaint'], 09:19:33 INFO - 'tests': ['Quantum_1']}, 09:19:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:33 INFO - 'tests': ['tsvgx', 09:19:33 INFO - 'tsvgr_opacity', 09:19:33 INFO - 'tart', 09:19:33 INFO - 'tscrollx', 09:19:33 INFO - 'cart', 09:19:33 INFO - 'tsvg_static']}, 09:19:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:33 INFO - 'tsvgr_opacity', 09:19:33 INFO - 'tart', 09:19:33 INFO - 'tscrollx', 09:19:33 INFO - 'cart', 09:19:33 INFO - 'tsvg_static']}, 09:19:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:19:33 INFO - 'talos_options': ['--disable-e10s'], 09:19:33 INFO - 'tests': ['tp5o']}, 09:19:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:19:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:19:33 INFO - 'talos_options': ['--disable-e10s', 09:19:33 INFO - '--xperf_path', 09:19:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:33 INFO - 'tests': ['tp5n']}, 09:19:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:19:33 INFO - 'talos_options': ['--xperf_path', 09:19:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:33 INFO - 'tests': ['tp5n']}}, 09:19:33 INFO - 'talos.zip': {'path': '', 09:19:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:33 INFO - Running post-action listener: _resource_record_post_action 09:19:33 INFO - [mozharness: 2017-06-03 16:19:33.570416Z] Finished populate-webroot step (success) 09:19:33 INFO - [mozharness: 2017-06-03 16:19:33.570504Z] Running create-virtualenv step. 09:19:33 INFO - Running pre-action listener: _resource_record_pre_action 09:19:33 INFO - Running main action method: create_virtualenv 09:19:33 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19: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 09:19:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:19:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:33 INFO - Using real prefix '/usr' 09:19:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:34 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:36 INFO - Installing pip.................done. 09:19:36 INFO - Return code: 0 09:19:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:19:36 INFO - Reading from file tmpfile_stdout 09:19:36 INFO - Output received: 09:19:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:19:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b840>, '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 0x1e7c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7cbd0>, '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-1496506233.647208-347624966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19: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', 'pip>=1.5'] in /builds/slave/test/build 09:19: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 pip>=1.5 09:19:36 INFO - Using env: {'DISPLAY': ':0', 09:19:36 INFO - 'HOME': '/home/cltbld', 09:19:36 INFO - 'LANG': 'en_US.UTF-8', 09:19:36 INFO - 'LANGUAGE': 'en_US:en', 09:19:36 INFO - 'LOGNAME': 'cltbld', 09:19:36 INFO - 'MAIL': '/var/mail/cltbld', 09:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:36 INFO - 'MOZ_NO_REMOTE': '1', 09:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:36 INFO - 'NO_EM_RESTART': '1', 09:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:36 INFO - 'PWD': '/builds/slave/test', 09:19:36 INFO - 'SHELL': '/bin/bash', 09:19:36 INFO - 'SHLVL': '1', 09:19:36 INFO - 'TERM': 'linux', 09:19:36 INFO - 'TMOUT': '86400', 09:19:36 INFO - 'USER': 'cltbld', 09:19:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496506233.647208-347624966', 09:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:36 INFO - '_': '/tools/buildbot/bin/python'} 09:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19: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 09:19:36 INFO - Cleaning up... 09:19:36 INFO - Return code: 0 09:19:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19: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 0x1b003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b840>, '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 0x1e7c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7cbd0>, '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-1496506233.647208-347624966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19: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 09:19: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 09:19:36 INFO - Using env: {'DISPLAY': ':0', 09:19:36 INFO - 'HOME': '/home/cltbld', 09:19:36 INFO - 'LANG': 'en_US.UTF-8', 09:19:36 INFO - 'LANGUAGE': 'en_US:en', 09:19:36 INFO - 'LOGNAME': 'cltbld', 09:19:36 INFO - 'MAIL': '/var/mail/cltbld', 09:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:36 INFO - 'MOZ_NO_REMOTE': '1', 09:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:36 INFO - 'NO_EM_RESTART': '1', 09:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:36 INFO - 'PWD': '/builds/slave/test', 09:19:36 INFO - 'SHELL': '/bin/bash', 09:19:36 INFO - 'SHLVL': '1', 09:19:36 INFO - 'TERM': 'linux', 09:19:36 INFO - 'TMOUT': '86400', 09:19:36 INFO - 'USER': 'cltbld', 09:19:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496506233.647208-347624966', 09:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:36 INFO - '_': '/tools/buildbot/bin/python'} 09:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:36 INFO - Downloading/unpacking psutil>=3.1.1 09:19: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 09:19: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 09:19: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 09:19: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 09:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:38 INFO - Installing collected packages: psutil 09:19:38 INFO - Running setup.py install for psutil 09:19:38 INFO - building 'psutil._psutil_linux' extension 09:19:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:19:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:19:38 INFO - building 'psutil._psutil_posix' extension 09:19:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:19:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:19:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:38 INFO - Successfully installed psutil 09:19:38 INFO - Cleaning up... 09:19:38 INFO - Return code: 0 09:19:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19: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')]} 09:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19: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 0x1b003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b840>, '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 0x1e7c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7cbd0>, '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-1496506233.647208-347624966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19: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 09:19: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 09:19:38 INFO - Using env: {'DISPLAY': ':0', 09:19:38 INFO - 'HOME': '/home/cltbld', 09:19:38 INFO - 'LANG': 'en_US.UTF-8', 09:19:38 INFO - 'LANGUAGE': 'en_US:en', 09:19:38 INFO - 'LOGNAME': 'cltbld', 09:19:38 INFO - 'MAIL': '/var/mail/cltbld', 09:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:38 INFO - 'MOZ_NO_REMOTE': '1', 09:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:38 INFO - 'NO_EM_RESTART': '1', 09:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:38 INFO - 'PWD': '/builds/slave/test', 09:19:38 INFO - 'SHELL': '/bin/bash', 09:19:38 INFO - 'SHLVL': '1', 09:19:38 INFO - 'TERM': 'linux', 09:19:38 INFO - 'TMOUT': '86400', 09:19:38 INFO - 'USER': 'cltbld', 09:19:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496506233.647208-347624966', 09:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:38 INFO - '_': '/tools/buildbot/bin/python'} 09:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19: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 09:19: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 09:19: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 09:19: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 09:19:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:39 INFO - Installing collected packages: mozsystemmonitor 09:19:39 INFO - Running setup.py install for mozsystemmonitor 09:19:39 INFO - Successfully installed mozsystemmonitor 09:19:39 INFO - Cleaning up... 09:19:40 INFO - Return code: 0 09:19:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:40 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 0x1b003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b840>, '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 0x1e7c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7cbd0>, '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-1496506233.647208-347624966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:19:40 INFO - Using env: {'DISPLAY': ':0', 09:19:40 INFO - 'HOME': '/home/cltbld', 09:19:40 INFO - 'LANG': 'en_US.UTF-8', 09:19:40 INFO - 'LANGUAGE': 'en_US:en', 09:19:40 INFO - 'LOGNAME': 'cltbld', 09:19:40 INFO - 'MAIL': '/var/mail/cltbld', 09:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:40 INFO - 'MOZ_NO_REMOTE': '1', 09:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:40 INFO - 'NO_EM_RESTART': '1', 09:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:40 INFO - 'PWD': '/builds/slave/test', 09:19:40 INFO - 'SHELL': '/bin/bash', 09:19:40 INFO - 'SHLVL': '1', 09:19:40 INFO - 'TERM': 'linux', 09:19:40 INFO - 'TMOUT': '86400', 09:19:40 INFO - 'USER': 'cltbld', 09:19:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496506233.647208-347624966', 09:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:40 INFO - '_': '/tools/buildbot/bin/python'} 09:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:40 INFO - Downloading/unpacking jsonschema==2.5.1 09:19: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 09:19: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 09:19: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 09:19: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 09:19:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19: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 09:19: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 09:19: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 09:19: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 09:19:41 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:41 INFO - warning: no files found matching '*.txt' 09:19:41 INFO - no previously-included directories found matching 'build' 09:19:41 INFO - no previously-included directories found matching 'dist' 09:19:41 INFO - no previously-included directories found matching '.git*' 09:19:41 INFO - Installing collected packages: jsonschema, functools32 09:19:41 INFO - Running setup.py install for functools32 09:19:41 INFO - warning: no files found matching '*.txt' 09:19:41 INFO - no previously-included directories found matching 'build' 09:19:41 INFO - no previously-included directories found matching 'dist' 09:19:41 INFO - no previously-included directories found matching '.git*' 09:19:41 INFO - Successfully installed jsonschema functools32 09:19:41 INFO - Cleaning up... 09:19:41 INFO - Return code: 0 09:19:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19: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')]} 09:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19: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 0x1b003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b840>, '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 0x1e7c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7cbd0>, '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-1496506233.647208-347624966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19: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 09:19: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 09:19:41 INFO - Using env: {'DISPLAY': ':0', 09:19:41 INFO - 'HOME': '/home/cltbld', 09:19:41 INFO - 'LANG': 'en_US.UTF-8', 09:19:41 INFO - 'LANGUAGE': 'en_US:en', 09:19:41 INFO - 'LOGNAME': 'cltbld', 09:19:41 INFO - 'MAIL': '/var/mail/cltbld', 09:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:41 INFO - 'MOZ_NO_REMOTE': '1', 09:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:41 INFO - 'NO_EM_RESTART': '1', 09:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:41 INFO - 'PWD': '/builds/slave/test', 09:19:41 INFO - 'SHELL': '/bin/bash', 09:19:41 INFO - 'SHLVL': '1', 09:19:41 INFO - 'TERM': 'linux', 09:19:41 INFO - 'TMOUT': '86400', 09:19:41 INFO - 'USER': 'cltbld', 09:19:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496506233.647208-347624966', 09:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:41 INFO - '_': '/tools/buildbot/bin/python'} 09:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:41 INFO - Cleaning up... 09:19:41 INFO - Return code: 0 09:19:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19: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')]} 09:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19: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 0x1b003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b840>, '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 0x1e7c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7cbd0>, '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-1496506233.647208-347624966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19: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 09:19: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 09:19:41 INFO - Using env: {'DISPLAY': ':0', 09:19:41 INFO - 'HOME': '/home/cltbld', 09:19:41 INFO - 'LANG': 'en_US.UTF-8', 09:19:41 INFO - 'LANGUAGE': 'en_US:en', 09:19:41 INFO - 'LOGNAME': 'cltbld', 09:19:41 INFO - 'MAIL': '/var/mail/cltbld', 09:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:41 INFO - 'MOZ_NO_REMOTE': '1', 09:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:41 INFO - 'NO_EM_RESTART': '1', 09:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:41 INFO - 'PWD': '/builds/slave/test', 09:19:41 INFO - 'SHELL': '/bin/bash', 09:19:41 INFO - 'SHLVL': '1', 09:19:41 INFO - 'TERM': 'linux', 09:19:41 INFO - 'TMOUT': '86400', 09:19:41 INFO - 'USER': 'cltbld', 09:19:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496506233.647208-347624966', 09:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:41 INFO - '_': '/tools/buildbot/bin/python'} 09:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:42 INFO - Downloading/unpacking blobuploader==1.2.4 09:19: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 09:19: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 09:19: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 09:19: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 09:19:43 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19: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 09:19: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 09:19: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 09:19: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 09:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19: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 09:19: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 09:19: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 09:19: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 09:19:43 INFO - Downloading docopt-0.6.1.tar.gz 09:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:43 INFO - Running setup.py install for blobuploader 09:19:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:43 INFO - Running setup.py install for requests 09:19:44 INFO - Running setup.py install for docopt 09:19:44 INFO - Successfully installed blobuploader requests docopt 09:19:44 INFO - Cleaning up... 09:19:44 INFO - Return code: 0 09:19:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:44 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 0x1b003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b840>, '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 0x1e7c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7cbd0>, '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-1496506233.647208-347624966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:19:44 INFO - Using env: {'DISPLAY': ':0', 09:19:44 INFO - 'HOME': '/home/cltbld', 09:19:44 INFO - 'LANG': 'en_US.UTF-8', 09:19:44 INFO - 'LANGUAGE': 'en_US:en', 09:19:44 INFO - 'LOGNAME': 'cltbld', 09:19:44 INFO - 'MAIL': '/var/mail/cltbld', 09:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:44 INFO - 'MOZ_NO_REMOTE': '1', 09:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:44 INFO - 'NO_EM_RESTART': '1', 09:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:44 INFO - 'PWD': '/builds/slave/test', 09:19:44 INFO - 'SHELL': '/bin/bash', 09:19:44 INFO - 'SHLVL': '1', 09:19:44 INFO - 'TERM': 'linux', 09:19:44 INFO - 'TMOUT': '86400', 09:19:44 INFO - 'USER': 'cltbld', 09:19:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496506233.647208-347624966', 09:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:44 INFO - '_': '/tools/buildbot/bin/python'} 09:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:44 INFO - Running setup.py (path:/tmp/pip-vQetfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:44 INFO - Running setup.py (path:/tmp/pip-a01oc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:44 INFO - Running setup.py (path:/tmp/pip-AidxZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:44 INFO - Running setup.py (path:/tmp/pip-KpCChe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:44 INFO - Running setup.py (path:/tmp/pip-BiBiEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:44 INFO - Running setup.py (path:/tmp/pip-LsoLCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:45 INFO - Running setup.py (path:/tmp/pip-lmvKy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:45 INFO - Running setup.py (path:/tmp/pip-gcgEhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:45 INFO - Running setup.py (path:/tmp/pip-fsUP3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:45 INFO - Running setup.py (path:/tmp/pip-l18szp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:45 INFO - Running setup.py (path:/tmp/pip-i2vlpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:45 INFO - Running setup.py (path:/tmp/pip-qFGc_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:45 INFO - Running setup.py (path:/tmp/pip-ss3qNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:45 INFO - Running setup.py (path:/tmp/pip-cMfTSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:45 INFO - Running setup.py (path:/tmp/pip-_OAwX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:45 INFO - Running setup.py (path:/tmp/pip-4iz3LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:45 INFO - Running setup.py (path:/tmp/pip-ovgjgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:45 INFO - Running setup.py install for manifestparser 09:19:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:45 INFO - Running setup.py install for mozcrash 09:19:46 INFO - Running setup.py install for mozdebug 09:19:46 INFO - Running setup.py install for mozdevice 09:19:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Running setup.py install for mozfile 09:19:46 INFO - Running setup.py install for mozhttpd 09:19:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Running setup.py install for mozinfo 09:19:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Running setup.py install for mozInstall 09:19:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Running setup.py install for mozleak 09:19:46 INFO - Running setup.py install for mozlog 09:19:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Running setup.py install for moznetwork 09:19:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:46 INFO - Running setup.py install for mozprocess 09:19:47 INFO - Running setup.py install for mozprofile 09:19:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:47 INFO - Running setup.py install for mozrunner 09:19:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:47 INFO - Running setup.py install for mozscreenshot 09:19:47 INFO - Running setup.py install for moztest 09:19:47 INFO - Running setup.py install for mozversion 09:19:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:47 INFO - Cleaning up... 09:19:47 INFO - Return code: 0 09:19:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19: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')]} 09:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19: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 0x1b003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b840>, '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 0x1e7c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7cbd0>, '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-1496506233.647208-347624966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19: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 09:19: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 09:19:47 INFO - Using env: {'DISPLAY': ':0', 09:19:47 INFO - 'HOME': '/home/cltbld', 09:19:47 INFO - 'LANG': 'en_US.UTF-8', 09:19:47 INFO - 'LANGUAGE': 'en_US:en', 09:19:47 INFO - 'LOGNAME': 'cltbld', 09:19:47 INFO - 'MAIL': '/var/mail/cltbld', 09:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:47 INFO - 'MOZ_NO_REMOTE': '1', 09:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:47 INFO - 'NO_EM_RESTART': '1', 09:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:47 INFO - 'PWD': '/builds/slave/test', 09:19:47 INFO - 'SHELL': '/bin/bash', 09:19:47 INFO - 'SHLVL': '1', 09:19:47 INFO - 'TERM': 'linux', 09:19:47 INFO - 'TMOUT': '86400', 09:19:47 INFO - 'USER': 'cltbld', 09:19:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496506233.647208-347624966', 09:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:47 INFO - '_': '/tools/buildbot/bin/python'} 09:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:47 INFO - Running setup.py (path:/tmp/pip-YJOTRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19: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)) 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:47 INFO - Running setup.py (path:/tmp/pip-t6t36z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19: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)) 09:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:47 INFO - Running setup.py (path:/tmp/pip-Ogi1Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:48 INFO - Running setup.py (path:/tmp/pip-nP7NCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:48 INFO - Running setup.py (path:/tmp/pip-SuHrL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:48 INFO - Running setup.py (path:/tmp/pip-sVTDMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:48 INFO - Running setup.py (path:/tmp/pip-moyKi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:48 INFO - Running setup.py (path:/tmp/pip-FQQ0yY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:48 INFO - Running setup.py (path:/tmp/pip-vZA_Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19: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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:48 INFO - Running setup.py (path:/tmp/pip-K5A4vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19: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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:48 INFO - Running setup.py (path:/tmp/pip-tDVj9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19: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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:48 INFO - Running setup.py (path:/tmp/pip-YO3D3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19: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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:48 INFO - Running setup.py (path:/tmp/pip-e2zG3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19: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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:48 INFO - Running setup.py (path:/tmp/pip-yK9W9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19: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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:48 INFO - Running setup.py (path:/tmp/pip-0UDVcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19: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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:48 INFO - Running setup.py (path:/tmp/pip-VIV34G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19: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)) 09:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:48 INFO - Running setup.py (path:/tmp/pip-CMhdUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:19:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:50 INFO - Downloading blessings-1.6.tar.gz 09:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:50 INFO - Installing collected packages: blessings 09:19:50 INFO - Running setup.py install for blessings 09:19:50 INFO - Successfully installed blessings 09:19:50 INFO - Cleaning up... 09:19:50 INFO - Return code: 0 09:19:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:50 INFO - Reading from file tmpfile_stdout 09:19:50 INFO - Current package versions: 09:19:50 INFO - argparse == 1.2.1 09:19:50 INFO - blessings == 1.6 09:19:50 INFO - blobuploader == 1.2.4 09:19:50 INFO - docopt == 0.6.1 09:19:50 INFO - functools32 == 3.2.3-2 09:19:50 INFO - jsonschema == 2.5.1 09:19:50 INFO - manifestparser == 1.1 09:19:50 INFO - mozInstall == 1.12 09:19:50 INFO - mozcrash == 1.0 09:19:50 INFO - mozdebug == 0.1 09:19:50 INFO - mozdevice == 0.51 09:19:50 INFO - mozfile == 1.2 09:19:50 INFO - mozhttpd == 0.7 09:19:50 INFO - mozinfo == 0.9 09:19:50 INFO - mozleak == 0.1 09:19:50 INFO - mozlog == 3.4 09:19:50 INFO - moznetwork == 0.27 09:19:50 INFO - mozprocess == 0.25 09:19:50 INFO - mozprofile == 0.28 09:19:50 INFO - mozrunner == 6.13 09:19:50 INFO - mozscreenshot == 0.1 09:19:50 INFO - mozsystemmonitor == 0.3 09:19:50 INFO - moztest == 0.8 09:19:50 INFO - mozversion == 1.4 09:19:50 INFO - psutil == 3.1.1 09:19:50 INFO - requests == 1.2.3 09:19:50 INFO - wsgiref == 0.1.2 09:19:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19: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')]} 09:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19: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 0x1b003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b840>, '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 0x1e7c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7cbd0>, '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-1496506233.647208-347624966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19: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 09:19: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 09:19:50 INFO - Using env: {'DISPLAY': ':0', 09:19:50 INFO - 'HOME': '/home/cltbld', 09:19:50 INFO - 'LANG': 'en_US.UTF-8', 09:19:50 INFO - 'LANGUAGE': 'en_US:en', 09:19:50 INFO - 'LOGNAME': 'cltbld', 09:19:50 INFO - 'MAIL': '/var/mail/cltbld', 09:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:50 INFO - 'MOZ_NO_REMOTE': '1', 09:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:50 INFO - 'NO_EM_RESTART': '1', 09:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:50 INFO - 'PWD': '/builds/slave/test', 09:19:50 INFO - 'SHELL': '/bin/bash', 09:19:50 INFO - 'SHLVL': '1', 09:19:50 INFO - 'TERM': 'linux', 09:19:50 INFO - 'TMOUT': '86400', 09:19:50 INFO - 'USER': 'cltbld', 09:19:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496506233.647208-347624966', 09:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:50 INFO - '_': '/tools/buildbot/bin/python'} 09:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19: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)) 09:19: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)) 09:19: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)) 09:19: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)) 09:19: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)) 09:19: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)) 09:19: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)) 09:19: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)) 09:19: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)) 09:19:50 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:19: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 09:19: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 09:19: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 09:19: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 09:19:51 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:19: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)) 09:19: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)) 09:19: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)) 09:19: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)) 09:19:51 INFO - Installing collected packages: marionette-driver 09:19:51 INFO - Running setup.py install for marionette-driver 09:19:52 INFO - Successfully installed marionette-driver 09:19:52 INFO - Cleaning up... 09:19:52 INFO - Return code: 0 09:19:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:52 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 0x1b003b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b840>, '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 0x1e7c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7cbd0>, '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-1496506233.647208-347624966', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:19:52 INFO - Using env: {'DISPLAY': ':0', 09:19:52 INFO - 'HOME': '/home/cltbld', 09:19:52 INFO - 'LANG': 'en_US.UTF-8', 09:19:52 INFO - 'LANGUAGE': 'en_US:en', 09:19:52 INFO - 'LOGNAME': 'cltbld', 09:19:52 INFO - 'MAIL': '/var/mail/cltbld', 09:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:52 INFO - 'MOZ_NO_REMOTE': '1', 09:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:52 INFO - 'NO_EM_RESTART': '1', 09:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:52 INFO - 'PWD': '/builds/slave/test', 09:19:52 INFO - 'SHELL': '/bin/bash', 09:19:52 INFO - 'SHLVL': '1', 09:19:52 INFO - 'TERM': 'linux', 09:19:52 INFO - 'TMOUT': '86400', 09:19:52 INFO - 'USER': 'cltbld', 09:19:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496506233.647208-347624966', 09:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:52 INFO - '_': '/tools/buildbot/bin/python'} 09:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:52 INFO - Cleaning up... 09:19:52 INFO - Return code: 0 09:19:52 INFO - Running post-action listener: _resource_record_post_action 09:19:52 INFO - Running post-action listener: _start_resource_monitoring 09:19:52 INFO - Starting resource monitoring. 09:19:52 INFO - [mozharness: 2017-06-03 16:19:52.397232Z] Finished create-virtualenv step (success) 09:19:52 INFO - [mozharness: 2017-06-03 16:19:52.397742Z] Running install step. 09:19:52 INFO - Running pre-action listener: _resource_record_pre_action 09:19:52 INFO - Running main action method: install 09:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:52 INFO - Reading from file tmpfile_stdout 09:19:52 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:52 INFO - Reading from file tmpfile_stdout 09:19:52 INFO - Output received: 09:19:52 INFO - Usage: mozinstall [options] installer 09:19:52 INFO - Options: 09:19:52 INFO - -h, --help show this help message and exit 09:19:52 INFO - -d DEST, --destination=DEST 09:19:52 INFO - Directory to install application into. [default: 09:19:52 INFO - "/builds/slave/test"] 09:19:52 INFO - --app=APP Application being installed. [default: firefox] 09:19:52 INFO - mkdir: /builds/slave/test/build/application 09:19: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'] 09:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:20:10 INFO - Reading from file tmpfile_stdout 09:20:10 INFO - Output received: 09:20:10 INFO - /builds/slave/test/build/application/firefox/firefox 09:20:10 INFO - Running post-action listener: _resource_record_post_action 09:20:10 INFO - [mozharness: 2017-06-03 16:20:10.111985Z] Finished install step (success) 09:20:10 INFO - [mozharness: 2017-06-03 16:20:10.112263Z] Running setup-mitmproxy step. 09:20:10 INFO - Running pre-action listener: _resource_record_pre_action 09:20:10 INFO - Running main action method: setup_mitmproxy 09:20:10 INFO - Skipping: mitmproxy is not required 09:20:10 INFO - Running post-action listener: _resource_record_post_action 09:20:10 INFO - [mozharness: 2017-06-03 16:20:10.113357Z] Finished setup-mitmproxy step (success) 09:20:10 INFO - [mozharness: 2017-06-03 16:20:10.113574Z] Running run-tests step. 09:20:10 INFO - Running pre-action listener: _resource_record_pre_action 09:20:10 INFO - Running main action method: run_tests 09:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:10 INFO - Python 2.7.3 09:20:10 INFO - Return code: 0 09:20:10 INFO - grabbing minidump binary from tooltool 09:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:10 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 0x1e7b840>, '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 0x1e7c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e7cbd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:20:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:20:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:20:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:10 INFO - Return code: 0 09:20:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:20:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:10 INFO - ENV: RUST_BACKTRACE is now 1 09:20:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:20:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:10 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/UGE2iFDrT826tnCCpYLODA/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 09:20:10 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/UGE2iFDrT826tnCCpYLODA/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 09:20:10 INFO - Using env: {'DISPLAY': ':0', 09:20:10 INFO - 'HOME': '/home/cltbld', 09:20:10 INFO - 'LANG': 'en_US.UTF-8', 09:20:10 INFO - 'LANGUAGE': 'en_US:en', 09:20:10 INFO - 'LOGNAME': 'cltbld', 09:20:10 INFO - 'MAIL': '/var/mail/cltbld', 09:20:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:10 INFO - 'MOZ_NO_REMOTE': '1', 09:20:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:10 INFO - 'NO_EM_RESTART': '1', 09:20:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:10 INFO - 'PWD': '/builds/slave/test', 09:20:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:10 INFO - 'RUST_BACKTRACE': '1', 09:20:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:20:10 INFO - 'SHELL': '/bin/bash', 09:20:10 INFO - 'SHLVL': '1', 09:20:10 INFO - 'TERM': 'linux', 09:20:10 INFO - 'TMOUT': '86400', 09:20:10 INFO - 'USER': 'cltbld', 09:20:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1496506233.647208-347624966', 09:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:10 INFO - '_': '/tools/buildbot/bin/python'} 09:20:10 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/UGE2iFDrT826tnCCpYLODA/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 09:20:10 INFO - mozversion application_buildid: 20170603153409 09:20:10 INFO - mozversion application_changeset: 98f1390029f9bd558de991a53c92342ac0addfc4 09:20:10 INFO - mozversion application_display_name: Nightly 09:20:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:10 INFO - mozversion application_name: Firefox 09:20:10 INFO - mozversion application_remotingname: firefox 09:20:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:20:10 INFO - mozversion application_vendor: Mozilla 09:20:10 INFO - mozversion application_version: 55.0a1 09:20:10 INFO - mozversion platform_buildid: 20170603153409 09:20:10 INFO - mozversion platform_changeset: 98f1390029f9bd558de991a53c92342ac0addfc4 09:20:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:20:10 INFO - mozversion platform_version: 55.0a1 09:20:10 INFO - using testdate: 1496506810 09:20:10 INFO - actual date: 1496506810 09:20:10 INFO - starting webserver on 'localhost:35810' 09:20:10 INFO - SUITE-START | Running 2 tests 09:20:10 INFO - TEST-START | dromaeo_css 09:20:10 INFO - operating with platform_type : linux_ 09:20:10 INFO - Initialising browser for dromaeo_css test... 09:20:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35810/getInfo.html -profile /tmp/tmpOI5qXK/profile 09:20:10 INFO - TEST-INFO | started process 14701 (/builds/slave/test/build/application/firefox/firefox http://localhost:35810/getInfo.html) 09:20:45 INFO - TEST-INFO | 14701: killed by SIGTERM 09:20:45 INFO - Browser initialized. 09:20:45 INFO - Running cycle 1/1 for dromaeo_css test... 09:20:45 INFO - TEST-INFO | started process 14928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOI5qXK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:57 INFO - PID 14928 | RSS: Main: 192651264 09:20:57 INFO - PID 14928 | 09:23:58 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:35810/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35810/tests/dromaeo/cssquery-ext.html) 09:24:00 INFO - PID 14928 | RSS: Main: 187891712 09:24:00 INFO - PID 14928 | 09:27:02 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:35810/tests/dromaeo/cssquery-ext.html (next: http://localhost:35810/tests/dromaeo/cssquery-jquery.html) 09:27:02 INFO - PID 14928 | RSS: Main: 194703360 09:27:02 INFO - PID 14928 | 09:30:04 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:35810/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35810/tests/dromaeo/cssquery-mootools.html) 09:30:05 INFO - PID 14928 | RSS: Main: 191954944 09:30:05 INFO - PID 14928 | 09:33:07 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:35810/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35810/tests/dromaeo/cssquery-prototype.html) 09:33:07 INFO - PID 14928 | RSS: Main: 194215936 09:33:07 INFO - PID 14928 | 09:36:10 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:35810/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35810/tests/dromaeo/cssquery-yui.html) 09:36:11 INFO - PID 14928 | RSS: Main: 193015808 09:36:11 INFO - PID 14928 | 09:39:13 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:35810/tests/dromaeo/cssquery-yui.html (next: http://localhost:35810/tests/dromaeo/cssquery-dojo.html) 09:39:13 INFO - PID 14928 | RSS: Main: 194686976 09:39:13 INFO - PID 14928 | 09:39:13 INFO - PID 14928 | __start_tp_report 09:39:13 INFO - PID 14928 | _x_x_mozilla_page_load 09:39:13 INFO - PID 14928 | _x_x_mozilla_page_load_details 09:39:13 INFO - PID 14928 | |i|pagename|runs| 09:39:13 INFO - PID 14928 | |0;dojo.html;3090.8454577271136;3142.1673256587023;3153.7477001839857;3179.5071763876576;3184.681531846815;5943.851403714899;5991.580589358747;6027.879442411149;6051.485623721984;6056.303525094615;5969.522438204944;5970.462658360758;5988.341282458937;6022.217111775463;6023.849403764908;5467.343918729758;5512.4211957744465;5636.351819540764;5649.689267090308;5656.2929633795775;5445.210444485548;5557.499825015748;5604.8318550443555;5608.747606357703;5636.323641163046;5525.917111243334;5587.608867379285;5605.383407825136;5641.12562552803;5668.914966275509;5423;5530.142827861688;5531.834044978657;5538.086215774392;5634.943650563483;5427.728613569306;5443.183522471661;5451.563874890039;5469.617126801126;5492.642978206404;5923.881522369528;5931.881362372728;5940.198073260141;5946.524278057788;5970.104484327386;6296.464800491964;6380.425761681471;6390.329015453403;6393.552451328409;6395.744170233185;6429.164208652845;6554.573952693059;6554.672266386661;6556.344365563453;6567.802965911031;6038.57729958903;6048;6050.031994880886;6061.121137435047;6061.181740465069;6479.125318082093;6659.533832631766;6661.26726060133;6663.200415950117;6666.899996500057;6278.246610406781;6296;6402.967985160044;6408.615483070937;6424.807255782334;6235.937640623626;6313.147725057059;6410.583312084699;6462.967685161544;6466.385693359123;6263.4362907338555;6272.247330320391;6277.937220627827;6287.434130928238;6293.937060629427;6295.5907865988565;6326.557141000178;6330.430261276507;6337.714802833883;6349.428551430394;5186;5186.870328241824;5242.633015688942;5264.52619264268;5273.815416460406;4478.619317357996;4489.887752806206;4493.707908985905;4519.141363140992;4583.587477127075;5525.226468294442;5537.086380747131;5537.252470916455;5537.889242215214;5571.60998730085;6352.745890164341;6414.294427612959;6459.192600924885;6479.611223326616;6553.115329430561;5560.944390556124;5570.888582228333;5574.693391863405;5600.271964644651;5629.127485239795;5673.404292549223;5677.205191273225;5677.460641239076;5701.344345400249;5718.399568045378;6165.9691701543;6221.4089661482085;6297.244330680348;6319.304876463585;6327;6460.67696615158;6560.179977502812;6567.540272180901;6576.704048317742;6577.7697780579365;6317.957537006527;6340;6347.174867267226;6349.809505714836;6383.585066970632;6352.205974253218;6366.9681651591445;6393.360663933569;6424.939884918936;6475.546711730133;6231.906521402092;6304.148939893055;6443.710033048618;6539.967300163468;6554;6294.8426289341305;6326.841828954129;6330.050492426173;6336.112944187726;6338.176037115146;6198.132261483306;6218.06728990655;6289.842753931189;6300.779472718433;6319.58922670025;6186.4741496971465;6217.160683307877;6246.6876656167915;6271.529635277281;6277.968610157102;6257.655828929453;6332.841678958063;6333.081703153109;6355.459785918249;6369.076483909715;6117.388261173847;6175.62946223228;6198.163247961648;6204.3795620439405;6250.281217660027 09:39:13 INFO - PID 14928 | |1;ext.html;709.6558169287895;752.4770284652167;770.7957391291307;1127.532074189211;1143.1940481960219;37051.81474092629;37891;38134.61865381342;38177.99999999993;38200;39763;40094;40226;40228.59771402285;40381.19237615246;7222.313880181375;7404;7426.962865185694;7509.69961201554;7521.323080922716;7343.302386273295;7411.88882166768;7438.367738742213;7446.180920098785;7458.701651933943;7403.185649578542;7463.51487153336;7463.850722985537;7467.551946883177;7471.551706897576;7391.6304184790815;7433.814154646123;7447.88828167578;7458;7484.363829074535;7341.74303899361;7353.154387245481;7367.263273672644;7387.150477695081;7395.149557800814;36532.45201321982;36876.26247475062;36941.445878311846;36969.260614787825;36988.26023479542;3469.340825243196;3517.9648203517895;3518.0852978225844;3518.9472157917653;3521.1725244567506;28574;28701;28702.712972870213;28712.282192945135;28735.425291494263;3520.6303338149637;3570.071781336845;3585.1933315004176;3601.027722514906;3608;141216.35134594605;142511;161375.3862461372;168402;168721;43264;43515.56484435115;43644.563554364686;43710.344344834855;43750;44952;44982.77508612502;44987;45019.77490112528;45060;14496.420143194366;14676.412943482355;14838.851611483962;14869.107853528823;14937;11788.410579471163;11797.705057373634;11804.114691398008;11807.704807379885;11852.88147118535;13564.253966031765;13568.660783480294;13684.794728079087;13706.177629342272;13876.861231387556;5486.506214440719;5498.790266141443;5519.862003449865;5718.256626638594;5731.799387021434;960.4573416019927;981.5681100315838;982.9655962041294;992.6079198716467;992.8758905136858;21997.23009694653;22569.322920312417;22757.772422275895;23603;23636.881815590812;1051.318077758232;1057.2810488867644;1067.3435836960368;1068.551208492435;1106.8727096384018;11599.826002609967;11925;12146;12568.245905245714;12646.747065058647;205287;206858;206991;207269;207768;49495;49574;49662.75168624134;49668.25497617538;49850;1315.9473621055051;1381.5924302330836;1382.2052319915888;1389.2428626398435;1432.5415866922692;21075.89462052741;21958.780412196313;23384.18155364554;23421.88289058544;23990.88004559966;36616.08459788527;43512.56487435085;44468.11063778771;44757.77621111873;44970;160709.196454017;162791;162895;163071.184644076;163376;31369.37261254808;31827.6817231834;32757.34485310328;33043.83478082594;33058.17354566155;40876.59123408728;42135.578644213165;42855.57144428516;43381.34927976146;43666.34500482432;29583.704162958096;30307;30330.696693032787;30729.53905691461;31866.84066579745;29979;29986.25034374158;30644;30903.69096309008;31211.90758323448;34310.313793723486;35396;35499.64500354963;35830.28339433249;35855.28289434144;28597.05151136193;29105.417891641624;29705.405891882474;30492.390152197277;31094.53358199674;21393.89303053475;24079.398015049064;24220.636690449304;24391.26826195217;24476.90288582943 09:39:13 INFO - PID 14928 | |2;jquery.html;411.99999999999983;419.7418587568644;420.93265077587586;423.5933503836317;427;20293.289734859263;20671;20939.05774240161;20993.160273589056;23098;23018.884905575447;23626;23664.64503032456;23677.289681309547;23681.76318236817;5996.550258730602;6121.296050954131;6126.142340072372;6127.724252408652;6136;6044.879102417949;6085.178500902388;6096.055111457709;6096.35988221237;6101.78643747469;5837.941620583803;5936.257967754031;5937.6140550864275;5945.970270148665;5947.762089516415;5871.119332100197;5894.734736936848;5904.143899134601;5911.911321330162;5917.615355001911;5239.528442440161;5265.6840589564745;5271.604629652791;5272.393674727417;5288.603354748409;25628.871855640602;26072;26091.347716307053;26186.607200892002;26215;1792.8117547657569;1844;1869.8504119670529;1870.0556219109399;1872.5880306332585;17101.2304446299;17323.653526929516;17403.651926961516;17414.912925435292;17418.564535886704;2187.147012665046;2238.4515793630503;2267.365137761413;2268.160780511205;2274.80664143548;115120.4243978783;122223.3888830559;125751.37124314411;126113;126620.36689816584;11091.889081109086;11336.716582085513;11378.658640240641;11401.771964560829;11667.6499705009;15195.848041519665;15294.541163765105;15319.157446340558;15333.463328783439;15378.538643840702;8701.216890479887;8730.257928076184;9012.63949442028;9026.517707630323;9059.229965452878;8759.781005474913;8774.60514276859;8794.20852123312;8906.465612063168;8940.3741738079;7339.7064117435775;7423.257674232642;7495.362894154058;7508.2867127622785;7607.429442791813;1934.6034063017048;1939.6120775844606;1951;1962.7546556680416;2077.605255001575;906.8413027720122;928.8606708993569;930.7998780262276;981.3572110267786;987.9675738852916;18466.81533184651;19142.808571914382;19458.610827783647;19713.507162321057;20808.58382832335;967.3470407475066;967.5597603090577;978.1124094952332;987.6592575561419;1031.6904928521565;10258.794824103476;10608.469576521144;12092.153549251643;13077.607671769862;13838.65403364924;447895;447932;451577;463785;464287;103915.48042259892;106247.4687626557;106253.46873265585;106844.99999999844;106886.46556767166;1131.7227279316455;1227.877212278765;1231.6243545718642;1232.6610182199968;1244.6017274472263;18663.720044199075;20171.61808482954;21250.14999400007;21417.215761950847;21465.67801482948;49497;49882.25176622281;50026.49973500364;50868.745656272964;51503;62569;62608;62663.68668156812;63059.684701576196;63433.365666344595;9936.801263974536;9958.103770660675;9982.850257246293;10013.048760367754;10083.394996300245;17488.475345739647;17723.556911077325;18000.819991799915;18089;18332.266709332012;15271.923640381727;15287.235638217822;15324.770128447859;15393.230338483256;15407.537773866801;13459.865401345862;14046.227457489527;14066.226357550433;14130;14182.361793719101;15203.31585078652;15243.847561524686;15557.455489058282;15606.453774117852;15716.371345146066;9877.703668889944;9927.652532161339;9971.501424928869;9995.050470205319;9997.900020999989;13941.721165576835;14056.086354386933;14071;14108;14141.222232777296 09:39:13 INFO - PID 14928 | |3;mootools.html;1257.0634877016623;1342.5972208337496;1353.688651610129;1361.7072329449172;1364.0383529611622;10874.238803283763;11365.886341136596;11367.261128026672;11384.089272858173;11755.648100468448;11262.887371126286;11317.773644527104;11426.828597571022;11460.369679667614;11491.310521368723;2340.4499942513494;2395.454931569137;2399.78401943825;2401;2401.267613377919;2320.234322673514;2430.987845060781;2439.9756002440013;2443.4746529496156;2443.841150325223;2348.295511346598;2360.0441821062414;2389.5459862626044;2390.0917651292484;2407.723111842143;2234.441389652587;2241.540484200735;2263.0721404224273;2263.411513006622;2266.2294819761196;2266.841321107523;2312.814974802012;2315.8263130265295;2319.8028167605776;2322.3613506285737;10748.301360411548;10944;10946.4526773661;10954.616588419367;10957.616483423122;6138.386161383871;6349.619022858643;6366.204224471941;6366.87266254677;6388.680565971683;3543.131932676485;3741.663250307485;3766.435034744783;3778.376567866299;3814.4278358246206;1241.4475558376525;1247.9064070194772;1253.7429826885557;1260.7730608490467;1285.254552359629;15756.76364854528;15969.680606387807;16000.679986400322;16002.839971600251;16580.502584922593;5097.082525145435;5133.281340612317;5230.032443997872;5299.735013249322;5317.9202311965355;12344.75310493785;12388.194767340094;12411.441485133191;12419.75160496785;12435.191712538655;6175.166352542439;6237.625742455467;6307.148534947815;6314;6316.778912738032;5729.1119876419225;5871.119332100134;5873.295204575478;5906.852328691817;5925.140854576062;4115.793229207927;4133.8966525837095;4145.751254924714;4171.186618609403;4182.163567286555;1216.7992281273669;1219.1161407979143;1231.6982339326921;1246.9501219951283;1248.7065539598186;786.1941509952345;807.7415227127262;812.8577498937663;825.0553116681486;885.751989442957;6536.7712130075215;6691.1636045494315;6746.797596072126;6834.829129271709;7215.134183897861;977.8093271811929;978.8776402949632;979.0028342182011;983.6262220356361;992.2310209587483;4101.651359634405;4107.712460127822;4252.532221455637;4320.611144996902;4336.241157797373;13692.31538423075;14153.646158846112;14191.219482928538;14216.075955062888;14278.143311401142;13351.265680387478;13898.58304250874;13951.860481395259;14003.50987715425;14268.072575282573;7727.806804829812;8457.407981441364;8657.783555411164;8798.560071996375;8802.86795698065;5845.883082338244;6636.966815165893;6845.220242736825;7012.483707745393;7018.157821061505;12871.806922895978;12950.352482376033;13252.271125088213;13341.599752007456;13573.932130339284;13133.146345487512;13294.268815215257;13312.667183320495;13426.932865336;13526.59420217395;10218.744531386776;10227.130693891102;10592.629257975934;10667.786644266916;10690.144788416752;10297.639582614573;10621.787564248827;10639.468026598484;10641.521131548943;10650.307729997525;8563.700270490503;8722.530885670798;9047.050059743633;9098;9148.359614826899;8227.300679442315;8321.167883211872;8397.454165479225;8435.409521333448;8436.198561136682;8028.839423211386;8137.75586732399;8138.796530086795;8189.771534269669;8192.54940978252;5276.9472305278;5575.135853942646;5585.581081418829;5646.632968857011;5675.4040825714355;5721.113227449586;5856.707164641836;5884.764609415575;6097.207363042776;6104.847378815388 09:39:13 INFO - PID 14928 | |4;prototype.html;389.0489196678656;399.9580044095369;400.49337587951266;404.1291017856518;404.548927945341;6169.629822210659;6274.709730948205;6288.905666415002;6303.243610766709;6327.145835312232;5996.2804463464445;6070.362611925751;6107.495926670055;6107.633541987484;6135.72389242484;4646.767661616923;4768.499307572707;4770.785314660849;4772.021735544223;4788.162071637467;4764.97617511912;4769.952300477003;4777.689450185744;4784.856454306377;4793.4487533933525;4704.317873908281;4725.196716558194;4761.714297142183;4768.259585251393;4768.952310476886;4754.833580824655;4773.06925149596;4774.2122549779415;4791.592714619244;4792.520747925215;4154.91690166198;4157;4165.312723400635;4167.74993500391;4173.6661067114555;6051.1225872248715;6060.909086363708;6105.168449465187;6109.266887973472;6118.4799292060225;5448.210009548633;5462.262594549725;5462.5083742462975;5470.91793623092;5481.342238931314;6485.772997945097;6539.803805885831;6558;6565.310642382528;6571.704273307712;4525.70582912113;4526.298423744325;4535.251683472223;4537.504372595059;4538;6561.80314590563;6770.76302329421;6849.589024658537;6912.965435172842;6936.09830722008;4348.499922508889;4514;4525.751083690363;4545.250033744395;4578.5421457853945;4557.293619488984;4624.329472226508;4643.326717625925;4647.140279048387;4668.719876807335;5236.214567814782;5351.357837059578;5363.793146541997;5364.034473794754;5380.910508013938;6538.313477084837;6545.967270163619;6555.672216389162;6565.770198043046;6570.474362051024;1606.8992739973155;1619.020492601959;1619.667968066567;1621.5459671292058;1631.6084139806599;1039.9376037437778;1068.8770791358938;1085.5603480590373;1096.0738176241064;1104.7127746785893;5722.971385143048;5744.712764361765;5761.724118972982;5766.596338256366;5788.913166302509;6710.463162946952;6792.830179245559;6795.830104247433;6808.570200257902;6829.146356705412;5674.2339784129435;5686.402927692616;5745.9712701437065;5756.971215143897;5760.884782304331;3575.1955809942556;3618.222082252328;3621.3843646580144;3623.4202527595457;3644.599094099647;6412.487001039905;6464.385883341075;6467.383154211447;6517.771877984248;6520.250171230275;6933.514653974275;6945.548539344926;6951.470676451173;6980.755673551402;6985.485225318881;6425.554250293647;6516;6550.934490655128;6567.507436942153;6570.390254387706;6738.393544581011;6756.763513277012;6762.560433571802;6769;6774.458043356618;6675.566088204251;6682.19813622349;6708.631025293461;6711.865762684622;6756.459483241427;6109.847253818512;6518.588122394554;6561.212654481302;6561.934380656132;6606.3393660635475;4516.503184649751;4517.50307466185;4535.569120933506;4564.566366195206;4574.428196475441;6732.865342693217;6762.898556521558;6775.695093720696;6792.966035169792;6798.52410331272;6361.236651601837;6515.54391192612;6529.542931994904;6572.76995305162;6601.966990165019;6554.934450655624;6586.1438013059915;6587.143671322889;6619;6619.801405957829;6358.332375100548;6465.547411681137;6485.77299794505;6506.902396463962;6517.446017088411;6568.934310656832;6576.8490514160785;6593.538452308292;6625.337466253336;6637.535372523877;6331.90502142459;6332.783525766129;6358.682065896779;6409.519286053472;6447.677616119082 09:39:13 INFO - PID 14928 | |5;yui.html;807.4711064252916;827.4910929778187;832.122111172713;832.1927730101803;854.8504011797937;15085.924570377147;15473.226338683064;15529.53411397657;16338.673226535462;17582.560435989108;16517.256723447445;16610.25592312808;16687.332506699717;16727.247273872676;16801.91599042003;953.5041778275292;974.1184228273424;981.7889153831925;982.5185659027097;982.7887004294075;931.2689538712112;957.9185769209626;976.1214906584061;978.4862946952835;978.6379039755301;1034.0848349210964;1034.2708390584658;1034.4982683398546;1035.140833108518;1037.501999040461;1025.4975062219532;1028.1209565821227;1032.8657274554334;1034.2398337222135;1038.6260946059488;758.8785794272945;760.0878945265704;761.6306091545651;762.7711686494085;763.9579823109726;15875.682486350208;16476.83523164777;16661.91669041647;16689.916550417292;16806.243719032675;17475;17748.645027099516;17834;17883.821161788346;18049.7292540612;14257.643558911006;14870.182139982297;14884;14932.104073755609;14962.027468214641;3402.2515046689687;3409.6590340965954;3410.539577157077;3416.02643246676;3637.872674456408;87091;88332.5583372079;88490.55754721249;89640.55179724125;89808;13705.588832335046;13982.161070335813;14160.787588186186;14184.645383865485;14518.128912265298;26687.599686004727;26770.19689409321;26936.865315673294;27480.862595686893;27742.306442339104;7216.3505284524645;7345.3021962913435;7801.726939557088;8342.749717508485;8356.916430835614;3930.744501607386;4016.9196616067516;4018.8392464301687;4020.718549701493;4027.234825383168;4028.335324671455;4111.383292506088;4111.753294802322;4126.401671757579;4132.318167502389;831.2518733140222;849.7578190215883;850.8511010573249;871.1941454154882;871.5511511571545;676.2797620534116;689.3657834792003;690.837653151509;694.506900100934;699.3251512290562;9894.604215831287;10339.896601034045;10900.182486313559;10995.955384238485;11653.88346116528;683.480554778372;686.5811854768588;688.5008368932483;701.3617607976716;714.5319815520842;4319.740815551077;4511.842085526991;4570.291604801261;4666.440027196758;4725.881852953704;88166.1183388158;90832;90834.54582727177;93275;93899;81668;84849;85363;85396;86155;69331;70135.64932175408;70400.2959970404;70447.64776176086;71165;9752.853707194256;9880.708759670577;10462.267641265038;10515.737106572396;10577.975989009808;28214.71785282121;28627.856860715565;28713.56929646015;29560.408791824473;29960.400791984473;53713;55876;56469.43530564806;56828;57606;15151.393944242107;15229.466968656045;15457.690846182788;15691.058536487848;15750.369985200463;15933.203339833193;16738.665226695153;16868.915655421646;17107.48677539676;17112.401065962633;14807.777883331542;15195.468158614396;15505.844941550891;15887;15903.840961590236;14479.276036197938;14530.273486325852;14735.484258050918;14817;16364.836351636808;14157.575272741835;14815.18516481604;14859.554213373616;15024.624384390478;15161.772573411186;11426.885731142582;11532.769344613229;11818;11996.76006479883;12347.814782778087;11960.342181180118;12420.254784712946;12867.806982895077;13294.734105317646;13307.26810025458 09:39:13 INFO - PID 14928 | __end_tp_report 09:39:13 INFO - PID 14928 | __start_cc_report 09:39:13 INFO - PID 14928 | _x_x_mozilla_cycle_collect,379 09:39:13 INFO - PID 14928 | __end_cc_report 09:39:13 INFO - PID 14928 | __startTimestamp1496507953458__endTimestamp 09:39:13 INFO - PID 14928 | 09:39:13 INFO - PID 14928 | ------- Summary: start ------- 09:39:13 INFO - PID 14928 | Number of tests: 6 09:39:13 INFO - PID 14928 | 09:39:13 INFO - PID 14928 | [#0] dojo.html Cycles:165 Average:5943.11 Median:6217.16 stddev:678.34 (10.9%) stddev-sans-first:642.46 09:39:13 INFO - PID 14928 | Values: 3090.8 3142.2 3153.7 3179.5 3184.7 5943.9 5991.6 6027.9 6051.5 6056.3 5969.5 5970.5 5988.3 6022.2 6023.8 5467.3 5512.4 5636.4 5649.7 5656.3 5445.2 5557.5 5604.8 5608.7 5636.3 5525.9 5587.6 5605.4 5641.1 5668.9 5423.0 5530.1 5531.8 5538.1 5634.9 5427.7 5443.2 5451.6 5469.6 5492.6 5923.9 5931.9 5940.2 5946.5 5970.1 6296.5 6380.4 6390.3 6393.6 6395.7 6429.2 6554.6 6554.7 6556.3 6567.8 6038.6 6048.0 6050.0 6061.1 6061.2 6479.1 6659.5 6661.3 6663.2 6666.9 6278.2 6296.0 6403.0 6408.6 6424.8 6235.9 6313.1 6410.6 6463.0 6466.4 6263.4 6272.2 6277.9 6287.4 6293.9 6295.6 6326.6 6330.4 6337.7 6349.4 5186.0 5186.9 5242.6 5264.5 5273.8 4478.6 4489.9 4493.7 4519.1 4583.6 5525.2 5537.1 5537.3 5537.9 5571.6 6352.7 6414.3 6459.2 6479.6 6553.1 5560.9 5570.9 5574.7 5600.3 5629.1 5673.4 5677.2 5677.5 5701.3 5718.4 6166.0 6221.4 6297.2 6319.3 6327.0 6460.7 6560.2 6567.5 6576.7 6577.8 6318.0 6340.0 6347.2 6349.8 6383.6 6352.2 6367.0 6393.4 6424.9 6475.5 6231.9 6304.1 6443.7 6540.0 6554.0 6294.8 6326.8 6330.1 6336.1 6338.2 6198.1 6218.1 6289.8 6300.8 6319.6 6186.5 6217.2 6246.7 6271.5 6278.0 6257.7 6332.8 6333.1 6355.5 6369.1 6117.4 6175.6 6198.2 6204.4 6250.3 09:39:13 INFO - PID 14928 | 09:39:13 INFO - PID 14928 | [#1] ext.html Cycles:180 Average:34103.68 Median:3518.52 stddev:45753.08 (1300.4%) stddev-sans-first:45812.72 09:39:13 INFO - PID 14928 | Values: 709.7 752.5 770.8 1127.5 1143.2 37051.8 37891.0 38134.6 38178.0 38200.0 39763.0 40094.0 40226.0 40228.6 40381.2 7222.3 7404.0 7427.0 7509.7 7521.3 7343.3 7411.9 7438.4 7446.2 7458.7 7403.2 7463.5 7463.9 7467.6 7471.6 7391.6 7433.8 7447.9 7458.0 7484.4 7341.7 7353.2 7367.3 7387.2 7395.1 36532.5 36876.3 36941.4 36969.3 36988.3 3469.3 3518.0 3518.1 3518.9 3521.2 28574.0 28701.0 28702.7 28712.3 28735.4 3520.6 3570.1 3585.2 3601.0 3608.0 141216.4 142511.0 161375.4 168402.0 168721.0 43264.0 43515.6 43644.6 43710.3 43750.0 44952.0 44982.8 44987.0 45019.8 45060.0 14496.4 14676.4 14838.9 14869.1 14937.0 11788.4 11797.7 11804.1 11807.7 11852.9 13564.3 13568.7 13684.8 13706.2 13876.9 5486.5 5498.8 5519.9 5718.3 5731.8 960.5 981.6 983.0 992.6 992.9 21997.2 22569.3 22757.8 23603.0 23636.9 1051.3 1057.3 1067.3 1068.6 1106.9 11599.8 11925.0 12146.0 12568.2 12646.7 205287.0 206858.0 206991.0 207269.0 207768.0 49495.0 49574.0 49662.8 49668.3 49850.0 1315.9 1381.6 1382.2 1389.2 1432.5 21075.9 21958.8 23384.2 23421.9 23990.9 36616.1 43512.6 44468.1 44757.8 44970.0 160709.2 162791.0 162895.0 163071.2 163376.0 31369.4 31827.7 32757.3 33043.8 33058.2 40876.6 42135.6 42855.6 43381.3 43666.3 29583.7 30307.0 30330.7 30729.5 31866.8 29979.0 29986.3 30644.0 30903.7 31211.9 34310.3 35396.0 35499.6 35830.3 35855.3 28597.1 29105.4 29705.4 30492.4 31094.5 21393.9 24079.4 24220.6 24391.3 24476.9 09:39:13 INFO - PID 14928 | 09:39:13 INFO - PID 14928 | [#2] jquery.html Cycles:180 Average:31256.41 Median:2271.48 stddev:76590.06 (3371.8%) stddev-sans-first:76769.90 09:39:13 INFO - PID 14928 | Values: 412.0 419.7 420.9 423.6 427.0 20293.3 20671.0 20939.1 20993.2 23098.0 23018.9 23626.0 23664.6 23677.3 23681.8 5996.6 6121.3 6126.1 6127.7 6136.0 6044.9 6085.2 6096.1 6096.4 6101.8 5837.9 5936.3 5937.6 5946.0 5947.8 5871.1 5894.7 5904.1 5911.9 5917.6 5239.5 5265.7 5271.6 5272.4 5288.6 25628.9 26072.0 26091.3 26186.6 26215.0 1792.8 1844.0 1869.9 1870.1 1872.6 17101.2 17323.7 17403.7 17414.9 17418.6 2187.1 2238.5 2267.4 2268.2 2274.8 115120.4 122223.4 125751.4 126113.0 126620.4 11091.9 11336.7 11378.7 11401.8 11667.6 15195.8 15294.5 15319.2 15333.5 15378.5 8701.2 8730.3 9012.6 9026.5 9059.2 8759.8 8774.6 8794.2 8906.5 8940.4 7339.7 7423.3 7495.4 7508.3 7607.4 1934.6 1939.6 1951.0 1962.8 2077.6 906.8 928.9 930.8 981.4 988.0 18466.8 19142.8 19458.6 19713.5 20808.6 967.3 967.6 978.1 987.7 1031.7 10258.8 10608.5 12092.2 13077.6 13838.7 447895.0 447932.0 451577.0 463785.0 464287.0 103915.5 106247.5 106253.5 106845.0 106886.5 1131.7 1227.9 1231.6 1232.7 1244.6 18663.7 20171.6 21250.1 21417.2 21465.7 49497.0 49882.3 50026.5 50868.7 51503.0 62569.0 62608.0 62663.7 63059.7 63433.4 9936.8 9958.1 9982.9 10013.0 10083.4 17488.5 17723.6 18000.8 18089.0 18332.3 15271.9 15287.2 15324.8 15393.2 15407.5 13459.9 14046.2 14066.2 14130.0 14182.4 15203.3 15243.8 15557.5 15606.5 15716.4 9877.7 9927.7 9971.5 9995.1 9997.9 13941.7 14056.1 14071.0 14108.0 14141.2 09:39:13 INFO - PID 14928 | 09:39:13 INFO - PID 14928 | [#3] mootools.html Cycles:180 Average:6936.52 Median:2419.36 stddev:4397.87 (181.8%) stddev-sans-first:4389.50 09:39:13 INFO - PID 14928 | Values: 1257.1 1342.6 1353.7 1361.7 1364.0 10874.2 11365.9 11367.3 11384.1 11755.6 11262.9 11317.8 11426.8 11460.4 11491.3 2340.4 2395.5 2399.8 2401.0 2401.3 2320.2 2431.0 2440.0 2443.5 2443.8 2348.3 2360.0 2389.5 2390.1 2407.7 2234.4 2241.5 2263.1 2263.4 2266.2 2266.8 2312.8 2315.8 2319.8 2322.4 10748.3 10944.0 10946.5 10954.6 10957.6 6138.4 6349.6 6366.2 6366.9 6388.7 3543.1 3741.7 3766.4 3778.4 3814.4 1241.4 1247.9 1253.7 1260.8 1285.3 15756.8 15969.7 16000.7 16002.8 16580.5 5097.1 5133.3 5230.0 5299.7 5317.9 12344.8 12388.2 12411.4 12419.8 12435.2 6175.2 6237.6 6307.1 6314.0 6316.8 5729.1 5871.1 5873.3 5906.9 5925.1 4115.8 4133.9 4145.8 4171.2 4182.2 1216.8 1219.1 1231.7 1247.0 1248.7 786.2 807.7 812.9 825.1 885.8 6536.8 6691.2 6746.8 6834.8 7215.1 977.8 978.9 979.0 983.6 992.2 4101.7 4107.7 4252.5 4320.6 4336.2 13692.3 14153.6 14191.2 14216.1 14278.1 13351.3 13898.6 13951.9 14003.5 14268.1 7727.8 8457.4 8657.8 8798.6 8802.9 5845.9 6637.0 6845.2 7012.5 7018.2 12871.8 12950.4 13252.3 13341.6 13573.9 13133.1 13294.3 13312.7 13426.9 13526.6 10218.7 10227.1 10592.6 10667.8 10690.1 10297.6 10621.8 10639.5 10641.5 10650.3 8563.7 8722.5 9047.1 9098.0 9148.4 8227.3 8321.2 8397.5 8435.4 8436.2 8028.8 8137.8 8138.8 8189.8 8192.5 5276.9 5575.1 5585.6 5646.6 5675.4 5721.1 5856.7 5884.8 6097.2 6104.8 09:39:13 INFO - PID 14928 | 09:39:13 INFO - PID 14928 | [#4] prototype.html Cycles:180 Average:5410.68 Median:6107.56 stddev:1615.45 (26.4%) stddev-sans-first:1575.40 09:39:13 INFO - PID 14928 | Values: 389.0 400.0 400.5 404.1 404.5 6169.6 6274.7 6288.9 6303.2 6327.1 5996.3 6070.4 6107.5 6107.6 6135.7 4646.8 4768.5 4770.8 4772.0 4788.2 4765.0 4770.0 4777.7 4784.9 4793.4 4704.3 4725.2 4761.7 4768.3 4769.0 4754.8 4773.1 4774.2 4791.6 4792.5 4154.9 4157.0 4165.3 4167.7 4173.7 6051.1 6060.9 6105.2 6109.3 6118.5 5448.2 5462.3 5462.5 5470.9 5481.3 6485.8 6539.8 6558.0 6565.3 6571.7 4525.7 4526.3 4535.3 4537.5 4538.0 6561.8 6770.8 6849.6 6913.0 6936.1 4348.5 4514.0 4525.8 4545.3 4578.5 4557.3 4624.3 4643.3 4647.1 4668.7 5236.2 5351.4 5363.8 5364.0 5380.9 6538.3 6546.0 6555.7 6565.8 6570.5 1606.9 1619.0 1619.7 1621.5 1631.6 1039.9 1068.9 1085.6 1096.1 1104.7 5723.0 5744.7 5761.7 5766.6 5788.9 6710.5 6792.8 6795.8 6808.6 6829.1 5674.2 5686.4 5746.0 5757.0 5760.9 3575.2 3618.2 3621.4 3623.4 3644.6 6412.5 6464.4 6467.4 6517.8 6520.3 6933.5 6945.5 6951.5 6980.8 6985.5 6425.6 6516.0 6550.9 6567.5 6570.4 6738.4 6756.8 6762.6 6769.0 6774.5 6675.6 6682.2 6708.6 6711.9 6756.5 6109.8 6518.6 6561.2 6561.9 6606.3 4516.5 4517.5 4535.6 4564.6 4574.4 6732.9 6762.9 6775.7 6793.0 6798.5 6361.2 6515.5 6529.5 6572.8 6602.0 6554.9 6586.1 6587.1 6619.0 6619.8 6358.3 6465.5 6485.8 6506.9 6517.4 6568.9 6576.8 6593.5 6625.3 6637.5 6331.9 6332.8 6358.7 6409.5 6447.7 09:39:13 INFO - PID 14928 | 09:39:13 INFO - PID 14928 | [#5] yui.html Cycles:180 Average:19388.13 Median:29760.40 stddev:25311.40 (85.1%) stddev-sans-first:25343.95 09:39:13 INFO - PID 14928 | Values: 807.5 827.5 832.1 832.2 854.9 15085.9 15473.2 15529.5 16338.7 17582.6 16517.3 16610.3 16687.3 16727.2 16801.9 953.5 974.1 981.8 982.5 982.8 931.3 957.9 976.1 978.5 978.6 1034.1 1034.3 1034.5 1035.1 1037.5 1025.5 1028.1 1032.9 1034.2 1038.6 758.9 760.1 761.6 762.8 764.0 15875.7 16476.8 16661.9 16689.9 16806.2 17475.0 17748.6 17834.0 17883.8 18049.7 14257.6 14870.2 14884.0 14932.1 14962.0 3402.3 3409.7 3410.5 3416.0 3637.9 87091.0 88332.6 88490.6 89640.6 89808.0 13705.6 13982.2 14160.8 14184.6 14518.1 26687.6 26770.2 26936.9 27480.9 27742.3 7216.4 7345.3 7801.7 8342.7 8356.9 3930.7 4016.9 4018.8 4020.7 4027.2 4028.3 4111.4 4111.8 4126.4 4132.3 831.3 849.8 850.9 871.2 871.6 676.3 689.4 690.8 694.5 699.3 9894.6 10339.9 10900.2 10996.0 11653.9 683.5 686.6 688.5 701.4 714.5 4319.7 4511.8 4570.3 4666.4 4725.9 88166.1 90832.0 90834.5 93275.0 93899.0 81668.0 84849.0 85363.0 85396.0 86155.0 69331.0 70135.6 70400.3 70447.6 71165.0 9752.9 9880.7 10462.3 10515.7 10578.0 28214.7 28627.9 28713.6 29560.4 29960.4 53713.0 55876.0 56469.4 56828.0 57606.0 15151.4 15229.5 15457.7 15691.1 15750.4 15933.2 16738.7 16868.9 17107.5 17112.4 14807.8 15195.5 15505.8 15887.0 15903.8 14479.3 14530.3 14735.5 14817.0 16364.8 14157.6 14815.2 14859.6 15024.6 15161.8 11426.9 11532.8 11818.0 11996.8 12347.8 11960.3 12420.3 12867.8 13294.7 13307.3 09:39:13 INFO - PID 14928 | -------- Summary: end -------- 09:39:13 INFO - PID 14928 | 09:39:14 INFO - TEST-INFO | 14928: exit 0 09:39:14 INFO - TEST-OK | dromaeo_css | took 1143980ms 09:39:14 INFO - TEST-START | kraken 09:39:14 INFO - operating with platform_type : linux_ 09:39:14 INFO - Initialising browser for kraken test... 09:39:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35810/getInfo.html -profile /tmp/tmpHLP0DJ/profile 09:39:14 INFO - TEST-INFO | started process 15357 (/builds/slave/test/build/application/firefox/firefox http://localhost:35810/getInfo.html) 09:39:49 INFO - TEST-INFO | 15357: killed by SIGTERM 09:39:49 INFO - Browser initialized. 09:39:49 INFO - Running cycle 1/1 for kraken test... 09:39:49 INFO - TEST-INFO | started process 15588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHLP0DJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:01 INFO - PID 15588 | RSS: Main: 192507904 09:40:01 INFO - PID 15588 | 09:40:04 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35810/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:05 INFO - PID 15588 | RSS: Main: 196001792 09:40:05 INFO - PID 15588 | 09:40:07 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35810/tests/kraken/driver.html?testName=audio-dft) 09:40:08 INFO - PID 15588 | RSS: Main: 194916352 09:40:08 INFO - PID 15588 | 09:40:11 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35810/tests/kraken/driver.html?testName=audio-fft) 09:40:12 INFO - PID 15588 | RSS: Main: 190152704 09:40:12 INFO - PID 15588 | 09:40:14 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35810/tests/kraken/driver.html?testName=audio-oscillator) 09:40:14 INFO - PID 15588 | RSS: Main: 191234048 09:40:14 INFO - PID 15588 | 09:40:16 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35810/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:17 INFO - PID 15588 | RSS: Main: 191291392 09:40:17 INFO - PID 15588 | 09:40:20 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35810/tests/kraken/driver.html?testName=imaging-darkroom) 09:40:21 INFO - PID 15588 | RSS: Main: 192520192 09:40:21 INFO - PID 15588 | 09:40:24 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35810/tests/kraken/driver.html?testName=imaging-desaturate) 09:40:25 INFO - PID 15588 | RSS: Main: 191336448 09:40:25 INFO - PID 15588 | 09:40:28 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35810/tests/kraken/driver.html?testName=json-parse-financial) 09:40:29 INFO - PID 15588 | RSS: Main: 192032768 09:40:29 INFO - PID 15588 | 09:40:30 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35810/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:40:31 INFO - PID 15588 | RSS: Main: 191975424 09:40:31 INFO - PID 15588 | 09:40:33 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35810/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:40:33 INFO - PID 15588 | RSS: Main: 191569920 09:40:33 INFO - PID 15588 | 09:40:35 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35810/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:40:36 INFO - PID 15588 | RSS: Main: 192032768 09:40:36 INFO - PID 15588 | 09:40:39 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:40:40 INFO - PID 15588 | RSS: Main: 191713280 09:40:40 INFO - PID 15588 | 09:40:43 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:40:43 INFO - PID 15588 | RSS: Main: 191397888 09:40:43 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | Cycle 1(1): loaded http://localhost:35810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35810/tests/kraken/driver.html?testName=ai-astar) 09:40:45 INFO - PID 15588 | RSS: Main: 193376256 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | __start_tp_report 09:40:45 INFO - PID 15588 | _x_x_mozilla_page_load 09:40:45 INFO - PID 15588 | _x_x_mozilla_page_load_details 09:40:45 INFO - PID 15588 | |i|pagename|runs| 09:40:45 INFO - PID 15588 | |0;ai-astar;101;110;110;110;111;110;109;110;110;110 09:40:45 INFO - PID 15588 | |1;audio-beat-detection;151;119;125;184;121;122;121;126;145;125 09:40:45 INFO - PID 15588 | |2;audio-dft;163;163;162;165;164;165;170;169;167;161 09:40:45 INFO - PID 15588 | |3;audio-fft;74;76;73;110;74;73;74;73;90;74 09:40:45 INFO - PID 15588 | |4;audio-oscillator;85;85;115;82;83;81;97;82;84;106 09:40:45 INFO - PID 15588 | |5;imaging-gaussian-blur;117;118;113;116;114;114;115;115;114;115 09:40:45 INFO - PID 15588 | |6;imaging-darkroom;150;151;150;152;150;150;151;151;152;150 09:40:45 INFO - PID 15588 | |7;imaging-desaturate;97;97;100;94;94;98;99;101;95;95 09:40:45 INFO - PID 15588 | |8;json-parse-financial;60;57;56;56;60;58;59;57;58;58 09:40:45 INFO - PID 15588 | |9;json-stringify-tinderbox;54;56;55;55;61;55;58;56;55;54 09:40:45 INFO - PID 15588 | |10;stanford-crypto-aes;87;86;86;95;84;87;89;89;108;87 09:40:45 INFO - PID 15588 | |11;stanford-crypto-ccm;133;130;141;138;133;137;141;148;136;134 09:40:45 INFO - PID 15588 | |12;stanford-crypto-pbkdf2;194;206;207;196;207;192;195;195;201;195 09:40:45 INFO - PID 15588 | |13;stanford-crypto-sha256-iterative;71;75;79;71;73;72;73;71;76;75 09:40:45 INFO - PID 15588 | __end_tp_report 09:40:45 INFO - PID 15588 | __start_cc_report 09:40:45 INFO - PID 15588 | _x_x_mozilla_cycle_collect,1007 09:40:45 INFO - PID 15588 | __end_cc_report 09:40:45 INFO - PID 15588 | __startTimestamp1496508045910__endTimestamp 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | ------- Summary: start ------- 09:40:45 INFO - PID 15588 | Number of tests: 14 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.88 (2.6%) stddev-sans-first:0.50 09:40:45 INFO - PID 15588 | Values: 101.0 110.0 110.0 110.0 111.0 110.0 109.0 110.0 110.0 110.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:125.50 stddev:20.66 (16.5%) stddev-sans-first:20.97 09:40:45 INFO - PID 15588 | Values: 151.0 119.0 125.0 184.0 121.0 122.0 121.0 126.0 145.0 125.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:2.96 (1.8%) stddev-sans-first:3.06 09:40:45 INFO - PID 15588 | Values: 163.0 163.0 162.0 165.0 164.0 165.0 170.0 169.0 167.0 161.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#3] audio-fft Cycles:10 Average:79.10 Median:74.00 stddev:12.01 (16.2%) stddev-sans-first:12.60 09:40:45 INFO - PID 15588 | Values: 74.0 76.0 73.0 110.0 74.0 73.0 74.0 73.0 90.0 74.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:83.50 stddev:11.90 (14.2%) stddev-sans-first:12.48 09:40:45 INFO - PID 15588 | Values: 85.0 85.0 115.0 82.0 83.0 81.0 97.0 82.0 84.0 106.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.52 (1.3%) stddev-sans-first:1.45 09:40:45 INFO - PID 15588 | Values: 117.0 118.0 113.0 116.0 114.0 114.0 115.0 115.0 114.0 115.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 09:40:45 INFO - PID 15588 | Values: 150.0 151.0 150.0 152.0 150.0 150.0 151.0 151.0 152.0 150.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:2.49 (2.6%) stddev-sans-first:2.65 09:40:45 INFO - PID 15588 | Values: 97.0 97.0 100.0 94.0 94.0 98.0 99.0 101.0 95.0 95.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:1.45 (2.5%) stddev-sans-first:1.32 09:40:45 INFO - PID 15588 | Values: 60.0 57.0 56.0 56.0 60.0 58.0 59.0 57.0 58.0 58.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:55.50 stddev:2.13 (3.8%) stddev-sans-first:2.15 09:40:45 INFO - PID 15588 | Values: 54.0 56.0 55.0 55.0 61.0 55.0 58.0 56.0 55.0 54.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:87.00 stddev:7.04 (8.1%) stddev-sans-first:7.39 09:40:45 INFO - PID 15588 | Values: 87.0 86.0 86.0 95.0 84.0 87.0 89.0 89.0 108.0 87.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:137.50 stddev:5.22 (3.8%) stddev-sans-first:5.32 09:40:45 INFO - PID 15588 | Values: 133.0 130.0 141.0 138.0 133.0 137.0 141.0 148.0 136.0 134.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.80 Median:198.50 stddev:5.88 (3.0%) stddev-sans-first:5.98 09:40:45 INFO - PID 15588 | Values: 194.0 206.0 207.0 196.0 207.0 192.0 195.0 195.0 201.0 195.0 09:40:45 INFO - PID 15588 | 09:40:45 INFO - PID 15588 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.00 stddev:2.63 (3.6%) stddev-sans-first:2.62 09:40:45 INFO - PID 15588 | Values: 71.0 75.0 79.0 71.0 73.0 72.0 73.0 71.0 76.0 75.0 09:40:45 INFO - PID 15588 | -------- Summary: end -------- 09:40:45 INFO - PID 15588 | 09:40:47 INFO - TEST-INFO | 15588: exit 0 09:40:47 INFO - TEST-OK | kraken | took 92761ms 09:40:47 INFO - SUITE-END | took 1236s 09:40:47 INFO - Completed test suite (00:20:37) 09:40:47 INFO - javascript benchmark 09:40:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7671.775715149662, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.8454577271136, 3142.1673256587023, 3153.7477001839857, 3179.5071763876576, 3184.681531846815, 5943.851403714899, 5991.580589358747, 6027.879442411149, 6051.485623721984, 6056.303525094615, 5969.522438204944, 5970.462658360758, 5988.341282458937, 6022.217111775463, 6023.849403764908, 5467.343918729758, 5512.4211957744465, 5636.351819540764, 5649.689267090308, 5656.2929633795775, 5445.210444485548, 5557.499825015748, 5604.8318550443555, 5608.747606357703, 5636.323641163046, 5525.917111243334, 5587.608867379285, 5605.383407825136, 5641.12562552803, 5668.914966275509, 5423.0, 5530.142827861688, 5531.834044978657, 5538.086215774392, 5634.943650563483, 5427.728613569306, 5443.183522471661, 5451.563874890039, 5469.617126801126, 5492.642978206404, 5923.881522369528, 5931.881362372728, 5940.198073260141, 5946.524278057788, 5970.104484327386, 6296.464800491964, 6380.425761681471, 6390.329015453403, 6393.552451328409, 6395.744170233185, 6429.164208652845, 6554.573952693059, 6554.672266386661, 6556.344365563453, 6567.802965911031, 6038.57729958903, 6048.0, 6050.031994880886, 6061.121137435047, 6061.181740465069, 6479.125318082093, 6659.533832631766, 6661.26726060133, 6663.200415950117, 6666.899996500057, 6278.246610406781, 6296.0, 6402.967985160044, 6408.615483070937, 6424.807255782334, 6235.937640623626, 6313.147725057059, 6410.583312084699, 6462.967685161544, 6466.385693359123, 6263.4362907338555, 6272.247330320391, 6277.937220627827, 6287.434130928238, 6293.937060629427, 6295.5907865988565, 6326.557141000178, 6330.430261276507, 6337.714802833883, 6349.428551430394, 5186.0, 5186.870328241824, 5242.633015688942, 5264.52619264268, 5273.815416460406, 4478.619317357996, 4489.887752806206, 4493.707908985905, 4519.141363140992, 4583.587477127075, 5525.226468294442, 5537.086380747131, 5537.252470916455, 5537.889242215214, 5571.60998730085, 6352.745890164341, 6414.294427612959, 6459.192600924885, 6479.611223326616, 6553.115329430561, 5560.944390556124, 5570.888582228333, 5574.693391863405, 5600.271964644651, 5629.127485239795, 5673.404292549223, 5677.205191273225, 5677.460641239076, 5701.344345400249, 5718.399568045378, 6165.9691701543, 6221.4089661482085, 6297.244330680348, 6319.304876463585, 6327.0, 6460.67696615158, 6560.179977502812, 6567.540272180901, 6576.704048317742, 6577.7697780579365, 6317.957537006527, 6340.0, 6347.174867267226, 6349.809505714836, 6383.585066970632, 6352.205974253218, 6366.9681651591445, 6393.360663933569, 6424.939884918936, 6475.546711730133, 6231.906521402092, 6304.148939893055, 6443.710033048618, 6539.967300163468, 6554.0, 6294.8426289341305, 6326.841828954129, 6330.050492426173, 6336.112944187726, 6338.176037115146, 6198.132261483306, 6218.06728990655, 6289.842753931189, 6300.779472718433, 6319.58922670025, 6186.4741496971465, 6217.160683307877, 6246.6876656167915, 6271.529635277281, 6277.968610157102, 6257.655828929453, 6332.841678958063, 6333.081703153109, 6355.459785918249, 6369.076483909715, 6117.388261173847, 6175.62946223228, 6198.163247961648, 6204.3795620439405, 6250.281217660027], "value": 5894.446268386152, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.6558169287895, 752.4770284652167, 770.7957391291307, 1127.532074189211, 1143.1940481960219, 37051.81474092629, 37891.0, 38134.61865381342, 38177.99999999993, 38200.0, 39763.0, 40094.0, 40226.0, 40228.59771402285, 40381.19237615246, 7222.313880181375, 7404.0, 7426.962865185694, 7509.69961201554, 7521.323080922716, 7343.302386273295, 7411.88882166768, 7438.367738742213, 7446.180920098785, 7458.701651933943, 7403.185649578542, 7463.51487153336, 7463.850722985537, 7467.551946883177, 7471.551706897576, 7391.6304184790815, 7433.814154646123, 7447.88828167578, 7458.0, 7484.363829074535, 7341.74303899361, 7353.154387245481, 7367.263273672644, 7387.150477695081, 7395.149557800814, 36532.45201321982, 36876.26247475062, 36941.445878311846, 36969.260614787825, 36988.26023479542, 3469.340825243196, 3517.9648203517895, 3518.0852978225844, 3518.9472157917653, 3521.1725244567506, 28574.0, 28701.0, 28702.712972870213, 28712.282192945135, 28735.425291494263, 3520.6303338149637, 3570.071781336845, 3585.1933315004176, 3601.027722514906, 3608.0, 141216.35134594605, 142511.0, 161375.3862461372, 168402.0, 168721.0, 43264.0, 43515.56484435115, 43644.563554364686, 43710.344344834855, 43750.0, 44952.0, 44982.77508612502, 44987.0, 45019.77490112528, 45060.0, 14496.420143194366, 14676.412943482355, 14838.851611483962, 14869.107853528823, 14937.0, 11788.410579471163, 11797.705057373634, 11804.114691398008, 11807.704807379885, 11852.88147118535, 13564.253966031765, 13568.660783480294, 13684.794728079087, 13706.177629342272, 13876.861231387556, 5486.506214440719, 5498.790266141443, 5519.862003449865, 5718.256626638594, 5731.799387021434, 960.4573416019927, 981.5681100315838, 982.9655962041294, 992.6079198716467, 992.8758905136858, 21997.23009694653, 22569.322920312417, 22757.772422275895, 23603.0, 23636.881815590812, 1051.318077758232, 1057.2810488867644, 1067.3435836960368, 1068.551208492435, 1106.8727096384018, 11599.826002609967, 11925.0, 12146.0, 12568.245905245714, 12646.747065058647, 205287.0, 206858.0, 206991.0, 207269.0, 207768.0, 49495.0, 49574.0, 49662.75168624134, 49668.25497617538, 49850.0, 1315.9473621055051, 1381.5924302330836, 1382.2052319915888, 1389.2428626398435, 1432.5415866922692, 21075.89462052741, 21958.780412196313, 23384.18155364554, 23421.88289058544, 23990.88004559966, 36616.08459788527, 43512.56487435085, 44468.11063778771, 44757.77621111873, 44970.0, 160709.196454017, 162791.0, 162895.0, 163071.184644076, 163376.0, 31369.37261254808, 31827.6817231834, 32757.34485310328, 33043.83478082594, 33058.17354566155, 40876.59123408728, 42135.578644213165, 42855.57144428516, 43381.34927976146, 43666.34500482432, 29583.704162958096, 30307.0, 30330.696693032787, 30729.53905691461, 31866.84066579745, 29979.0, 29986.25034374158, 30644.0, 30903.69096309008, 31211.90758323448, 34310.313793723486, 35396.0, 35499.64500354963, 35830.28339433249, 35855.28289434144, 28597.05151136193, 29105.417891641624, 29705.405891882474, 30492.390152197277, 31094.53358199674, 21393.89303053475, 24079.398015049064, 24220.636690449304, 24391.26826195217, 24476.90288582943], "value": 16210.346448946948, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.99999999999983, 419.7418587568644, 420.93265077587586, 423.5933503836317, 427.0, 20293.289734859263, 20671.0, 20939.05774240161, 20993.160273589056, 23098.0, 23018.884905575447, 23626.0, 23664.64503032456, 23677.289681309547, 23681.76318236817, 5996.550258730602, 6121.296050954131, 6126.142340072372, 6127.724252408652, 6136.0, 6044.879102417949, 6085.178500902388, 6096.055111457709, 6096.35988221237, 6101.78643747469, 5837.941620583803, 5936.257967754031, 5937.6140550864275, 5945.970270148665, 5947.762089516415, 5871.119332100197, 5894.734736936848, 5904.143899134601, 5911.911321330162, 5917.615355001911, 5239.528442440161, 5265.6840589564745, 5271.604629652791, 5272.393674727417, 5288.603354748409, 25628.871855640602, 26072.0, 26091.347716307053, 26186.607200892002, 26215.0, 1792.8117547657569, 1844.0, 1869.8504119670529, 1870.0556219109399, 1872.5880306332585, 17101.2304446299, 17323.653526929516, 17403.651926961516, 17414.912925435292, 17418.564535886704, 2187.147012665046, 2238.4515793630503, 2267.365137761413, 2268.160780511205, 2274.80664143548, 115120.4243978783, 122223.3888830559, 125751.37124314411, 126113.0, 126620.36689816584, 11091.889081109086, 11336.716582085513, 11378.658640240641, 11401.771964560829, 11667.6499705009, 15195.848041519665, 15294.541163765105, 15319.157446340558, 15333.463328783439, 15378.538643840702, 8701.216890479887, 8730.257928076184, 9012.63949442028, 9026.517707630323, 9059.229965452878, 8759.781005474913, 8774.60514276859, 8794.20852123312, 8906.465612063168, 8940.3741738079, 7339.7064117435775, 7423.257674232642, 7495.362894154058, 7508.2867127622785, 7607.429442791813, 1934.6034063017048, 1939.6120775844606, 1951.0, 1962.7546556680416, 2077.605255001575, 906.8413027720122, 928.8606708993569, 930.7998780262276, 981.3572110267786, 987.9675738852916, 18466.81533184651, 19142.808571914382, 19458.610827783647, 19713.507162321057, 20808.58382832335, 967.3470407475066, 967.5597603090577, 978.1124094952332, 987.6592575561419, 1031.6904928521565, 10258.794824103476, 10608.469576521144, 12092.153549251643, 13077.607671769862, 13838.65403364924, 447895.0, 447932.0, 451577.0, 463785.0, 464287.0, 103915.48042259892, 106247.4687626557, 106253.46873265585, 106844.99999999844, 106886.46556767166, 1131.7227279316455, 1227.877212278765, 1231.6243545718642, 1232.6610182199968, 1244.6017274472263, 18663.720044199075, 20171.61808482954, 21250.14999400007, 21417.215761950847, 21465.67801482948, 49497.0, 49882.25176622281, 50026.49973500364, 50868.745656272964, 51503.0, 62569.0, 62608.0, 62663.68668156812, 63059.684701576196, 63433.365666344595, 9936.801263974536, 9958.103770660675, 9982.850257246293, 10013.048760367754, 10083.394996300245, 17488.475345739647, 17723.556911077325, 18000.819991799915, 18089.0, 18332.266709332012, 15271.923640381727, 15287.235638217822, 15324.770128447859, 15393.230338483256, 15407.537773866801, 13459.865401345862, 14046.227457489527, 14066.226357550433, 14130.0, 14182.361793719101, 15203.31585078652, 15243.847561524686, 15557.455489058282, 15606.453774117852, 15716.371345146066, 9877.703668889944, 9927.652532161339, 9971.501424928869, 9995.050470205319, 9997.900020999989, 13941.721165576835, 14056.086354386933, 14071.0, 14108.0, 14141.222232777296], "value": 10437.21575603219, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.0634877016623, 1342.5972208337496, 1353.688651610129, 1361.7072329449172, 1364.0383529611622, 10874.238803283763, 11365.886341136596, 11367.261128026672, 11384.089272858173, 11755.648100468448, 11262.887371126286, 11317.773644527104, 11426.828597571022, 11460.369679667614, 11491.310521368723, 2340.4499942513494, 2395.454931569137, 2399.78401943825, 2401.0, 2401.267613377919, 2320.234322673514, 2430.987845060781, 2439.9756002440013, 2443.4746529496156, 2443.841150325223, 2348.295511346598, 2360.0441821062414, 2389.5459862626044, 2390.0917651292484, 2407.723111842143, 2234.441389652587, 2241.540484200735, 2263.0721404224273, 2263.411513006622, 2266.2294819761196, 2266.841321107523, 2312.814974802012, 2315.8263130265295, 2319.8028167605776, 2322.3613506285737, 10748.301360411548, 10944.0, 10946.4526773661, 10954.616588419367, 10957.616483423122, 6138.386161383871, 6349.619022858643, 6366.204224471941, 6366.87266254677, 6388.680565971683, 3543.131932676485, 3741.663250307485, 3766.435034744783, 3778.376567866299, 3814.4278358246206, 1241.4475558376525, 1247.9064070194772, 1253.7429826885557, 1260.7730608490467, 1285.254552359629, 15756.76364854528, 15969.680606387807, 16000.679986400322, 16002.839971600251, 16580.502584922593, 5097.082525145435, 5133.281340612317, 5230.032443997872, 5299.735013249322, 5317.9202311965355, 12344.75310493785, 12388.194767340094, 12411.441485133191, 12419.75160496785, 12435.191712538655, 6175.166352542439, 6237.625742455467, 6307.148534947815, 6314.0, 6316.778912738032, 5729.1119876419225, 5871.119332100134, 5873.295204575478, 5906.852328691817, 5925.140854576062, 4115.793229207927, 4133.8966525837095, 4145.751254924714, 4171.186618609403, 4182.163567286555, 1216.7992281273669, 1219.1161407979143, 1231.6982339326921, 1246.9501219951283, 1248.7065539598186, 786.1941509952345, 807.7415227127262, 812.8577498937663, 825.0553116681486, 885.751989442957, 6536.7712130075215, 6691.1636045494315, 6746.797596072126, 6834.829129271709, 7215.134183897861, 977.8093271811929, 978.8776402949632, 979.0028342182011, 983.6262220356361, 992.2310209587483, 4101.651359634405, 4107.712460127822, 4252.532221455637, 4320.611144996902, 4336.241157797373, 13692.31538423075, 14153.646158846112, 14191.219482928538, 14216.075955062888, 14278.143311401142, 13351.265680387478, 13898.58304250874, 13951.860481395259, 14003.50987715425, 14268.072575282573, 7727.806804829812, 8457.407981441364, 8657.783555411164, 8798.560071996375, 8802.86795698065, 5845.883082338244, 6636.966815165893, 6845.220242736825, 7012.483707745393, 7018.157821061505, 12871.806922895978, 12950.352482376033, 13252.271125088213, 13341.599752007456, 13573.932130339284, 13133.146345487512, 13294.268815215257, 13312.667183320495, 13426.932865336, 13526.59420217395, 10218.744531386776, 10227.130693891102, 10592.629257975934, 10667.786644266916, 10690.144788416752, 10297.639582614573, 10621.787564248827, 10639.468026598484, 10641.521131548943, 10650.307729997525, 8563.700270490503, 8722.530885670798, 9047.050059743633, 9098.0, 9148.359614826899, 8227.300679442315, 8321.167883211872, 8397.454165479225, 8435.409521333448, 8436.198561136682, 8028.839423211386, 8137.75586732399, 8138.796530086795, 8189.771534269669, 8192.54940978252, 5276.9472305278, 5575.135853942646, 5585.581081418829, 5646.632968857011, 5675.4040825714355, 5721.113227449586, 5856.707164641836, 5884.764609415575, 6097.207363042776, 6104.847378815388], "value": 5239.7989069121895, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.0489196678656, 399.9580044095369, 400.49337587951266, 404.1291017856518, 404.548927945341, 6169.629822210659, 6274.709730948205, 6288.905666415002, 6303.243610766709, 6327.145835312232, 5996.2804463464445, 6070.362611925751, 6107.495926670055, 6107.633541987484, 6135.72389242484, 4646.767661616923, 4768.499307572707, 4770.785314660849, 4772.021735544223, 4788.162071637467, 4764.97617511912, 4769.952300477003, 4777.689450185744, 4784.856454306377, 4793.4487533933525, 4704.317873908281, 4725.196716558194, 4761.714297142183, 4768.259585251393, 4768.952310476886, 4754.833580824655, 4773.06925149596, 4774.2122549779415, 4791.592714619244, 4792.520747925215, 4154.91690166198, 4157.0, 4165.312723400635, 4167.74993500391, 4173.6661067114555, 6051.1225872248715, 6060.909086363708, 6105.168449465187, 6109.266887973472, 6118.4799292060225, 5448.210009548633, 5462.262594549725, 5462.5083742462975, 5470.91793623092, 5481.342238931314, 6485.772997945097, 6539.803805885831, 6558.0, 6565.310642382528, 6571.704273307712, 4525.70582912113, 4526.298423744325, 4535.251683472223, 4537.504372595059, 4538.0, 6561.80314590563, 6770.76302329421, 6849.589024658537, 6912.965435172842, 6936.09830722008, 4348.499922508889, 4514.0, 4525.751083690363, 4545.250033744395, 4578.5421457853945, 4557.293619488984, 4624.329472226508, 4643.326717625925, 4647.140279048387, 4668.719876807335, 5236.214567814782, 5351.357837059578, 5363.793146541997, 5364.034473794754, 5380.910508013938, 6538.313477084837, 6545.967270163619, 6555.672216389162, 6565.770198043046, 6570.474362051024, 1606.8992739973155, 1619.020492601959, 1619.667968066567, 1621.5459671292058, 1631.6084139806599, 1039.9376037437778, 1068.8770791358938, 1085.5603480590373, 1096.0738176241064, 1104.7127746785893, 5722.971385143048, 5744.712764361765, 5761.724118972982, 5766.596338256366, 5788.913166302509, 6710.463162946952, 6792.830179245559, 6795.830104247433, 6808.570200257902, 6829.146356705412, 5674.2339784129435, 5686.402927692616, 5745.9712701437065, 5756.971215143897, 5760.884782304331, 3575.1955809942556, 3618.222082252328, 3621.3843646580144, 3623.4202527595457, 3644.599094099647, 6412.487001039905, 6464.385883341075, 6467.383154211447, 6517.771877984248, 6520.250171230275, 6933.514653974275, 6945.548539344926, 6951.470676451173, 6980.755673551402, 6985.485225318881, 6425.554250293647, 6516.0, 6550.934490655128, 6567.507436942153, 6570.390254387706, 6738.393544581011, 6756.763513277012, 6762.560433571802, 6769.0, 6774.458043356618, 6675.566088204251, 6682.19813622349, 6708.631025293461, 6711.865762684622, 6756.459483241427, 6109.847253818512, 6518.588122394554, 6561.212654481302, 6561.934380656132, 6606.3393660635475, 4516.503184649751, 4517.50307466185, 4535.569120933506, 4564.566366195206, 4574.428196475441, 6732.865342693217, 6762.898556521558, 6775.695093720696, 6792.966035169792, 6798.52410331272, 6361.236651601837, 6515.54391192612, 6529.542931994904, 6572.76995305162, 6601.966990165019, 6554.934450655624, 6586.1438013059915, 6587.143671322889, 6619.0, 6619.801405957829, 6358.332375100548, 6465.547411681137, 6485.77299794505, 6506.902396463962, 6517.446017088411, 6568.934310656832, 6576.8490514160785, 6593.538452308292, 6625.337466253336, 6637.535372523877, 6331.90502142459, 6332.783525766129, 6358.682065896779, 6409.519286053472, 6447.677616119082], "value": 4900.2293938952225, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.4711064252916, 827.4910929778187, 832.122111172713, 832.1927730101803, 854.8504011797937, 15085.924570377147, 15473.226338683064, 15529.53411397657, 16338.673226535462, 17582.560435989108, 16517.256723447445, 16610.25592312808, 16687.332506699717, 16727.247273872676, 16801.91599042003, 953.5041778275292, 974.1184228273424, 981.7889153831925, 982.5185659027097, 982.7887004294075, 931.2689538712112, 957.9185769209626, 976.1214906584061, 978.4862946952835, 978.6379039755301, 1034.0848349210964, 1034.2708390584658, 1034.4982683398546, 1035.140833108518, 1037.501999040461, 1025.4975062219532, 1028.1209565821227, 1032.8657274554334, 1034.2398337222135, 1038.6260946059488, 758.8785794272945, 760.0878945265704, 761.6306091545651, 762.7711686494085, 763.9579823109726, 15875.682486350208, 16476.83523164777, 16661.91669041647, 16689.916550417292, 16806.243719032675, 17475.0, 17748.645027099516, 17834.0, 17883.821161788346, 18049.7292540612, 14257.643558911006, 14870.182139982297, 14884.0, 14932.104073755609, 14962.027468214641, 3402.2515046689687, 3409.6590340965954, 3410.539577157077, 3416.02643246676, 3637.872674456408, 87091.0, 88332.5583372079, 88490.55754721249, 89640.55179724125, 89808.0, 13705.588832335046, 13982.161070335813, 14160.787588186186, 14184.645383865485, 14518.128912265298, 26687.599686004727, 26770.19689409321, 26936.865315673294, 27480.862595686893, 27742.306442339104, 7216.3505284524645, 7345.3021962913435, 7801.726939557088, 8342.749717508485, 8356.916430835614, 3930.744501607386, 4016.9196616067516, 4018.8392464301687, 4020.718549701493, 4027.234825383168, 4028.335324671455, 4111.383292506088, 4111.753294802322, 4126.401671757579, 4132.318167502389, 831.2518733140222, 849.7578190215883, 850.8511010573249, 871.1941454154882, 871.5511511571545, 676.2797620534116, 689.3657834792003, 690.837653151509, 694.506900100934, 699.3251512290562, 9894.604215831287, 10339.896601034045, 10900.182486313559, 10995.955384238485, 11653.88346116528, 683.480554778372, 686.5811854768588, 688.5008368932483, 701.3617607976716, 714.5319815520842, 4319.740815551077, 4511.842085526991, 4570.291604801261, 4666.440027196758, 4725.881852953704, 88166.1183388158, 90832.0, 90834.54582727177, 93275.0, 93899.0, 81668.0, 84849.0, 85363.0, 85396.0, 86155.0, 69331.0, 70135.64932175408, 70400.2959970404, 70447.64776176086, 71165.0, 9752.853707194256, 9880.708759670577, 10462.267641265038, 10515.737106572396, 10577.975989009808, 28214.71785282121, 28627.856860715565, 28713.56929646015, 29560.408791824473, 29960.400791984473, 53713.0, 55876.0, 56469.43530564806, 56828.0, 57606.0, 15151.393944242107, 15229.466968656045, 15457.690846182788, 15691.058536487848, 15750.369985200463, 15933.203339833193, 16738.665226695153, 16868.915655421646, 17107.48677539676, 17112.401065962633, 14807.777883331542, 15195.468158614396, 15505.844941550891, 15887.0, 15903.840961590236, 14479.276036197938, 14530.273486325852, 14735.484258050918, 14817.0, 16364.836351636808, 14157.575272741835, 14815.18516481604, 14859.554213373616, 15024.624384390478, 15161.772573411186, 11426.885731142582, 11532.769344613229, 11818.0, 11996.76006479883, 12347.814782778087, 11960.342181180118, 12420.254784712946, 12867.806982895077, 13294.734105317646, 13307.26810025458], "value": 7961.518478558588, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 119.0, 125.0, 184.0, 121.0, 122.0, 121.0, 126.0, 145.0, 125.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 165.0, 164.0, 165.0, 170.0, 169.0, 167.0, 161.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 110.0, 74.0, 73.0, 74.0, 73.0, 90.0, 74.0], "value": 79.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 82.0, 83.0, 81.0, 97.0, 82.0, 84.0, 106.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 113.0, 116.0, 114.0, 114.0, 115.0, 115.0, 114.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 152.0, 150.0, 150.0, 151.0, 151.0, 152.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 100.0, 94.0, 94.0, 98.0, 99.0, 101.0, 95.0, 95.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 56.0, 56.0, 60.0, 58.0, 59.0, 57.0, 58.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 55.0, 61.0, 55.0, 58.0, 56.0, 55.0, 54.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 95.0, 84.0, 87.0, 89.0, 89.0, 108.0, 87.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 141.0, 138.0, 133.0, 137.0, 141.0, 148.0, 136.0, 134.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 206.0, 207.0, 196.0, 207.0, 192.0, 195.0, 195.0, 201.0, 195.0], "value": 198.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 79.0, 71.0, 73.0, 72.0, 73.0, 71.0, 76.0, 75.0], "value": 73.6, "unit": "score"}]}]} 09:40:47 INFO - Return code: 0 09:40:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:40:47 INFO - # TBPL SUCCESS # 09:40:47 INFO - Running post-action listener: _resource_record_post_action 09:40:47 INFO - [mozharness: 2017-06-03 16:40:47.771488Z] Finished run-tests step (success) 09:40:47 INFO - Running post-run listener: _resource_record_post_run 09:40:47 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 884736; Write bytes: 442281984; Read time: 168; Write time: 259700 09:40:47 INFO - TinderboxPrint: CPU usage
12.7% 09:40:47 INFO - TinderboxPrint: I/O read bytes / time
884,736 / 168 09:40:47 INFO - TinderboxPrint: I/O write bytes / time
442,281,984 / 259,700 09:40:47 INFO - TinderboxPrint: CPU idle
8,744.3 (87.3%) 09:40:47 INFO - TinderboxPrint: CPU user
1,214.4 (12.1%) 09:40:47 INFO - TinderboxPrint: Swap in / out
0 / 0 09:40:47 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 116707328; Read time: 0; Write time: 88932 09:40:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:40:47 INFO - run-tests - Wall time: 1238s; CPU: 13.0%; Read bytes: 884736; Write bytes: 325574656; Read time: 168; Write time: 170768 09:40:48 INFO - Running post-run listener: _upload_blobber_files 09:40:48 INFO - Blob upload gear active. 09:40:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:40:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:40:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:40:48 INFO - (blobuploader) - INFO - Open directory for files ... 09:40:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:40:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:40:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:52 INFO - (blobuploader) - INFO - Done attempting. 09:40:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:40:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:40:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:53 INFO - (blobuploader) - INFO - Done attempting. 09:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:54 INFO - (blobuploader) - INFO - Done attempting. 09:40:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:40:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:54 INFO - (blobuploader) - INFO - Done attempting. 09:40:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:40:54 INFO - Return code: 0 09:40:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:40:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:40:54 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5bea600e510d8c3650dcd230d8951dcf1c53af79e2e33a8483fed6ef370d8648e4c8c9c8bdf7f76f1fd15ee2521a38c7f6f95fb5552e6764a8de35351029df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/031b0df8ca8ec727ff44ecd193f15c2b9444ba776e8c21c875e717df231d7556ac5dde5d46cb4887f0dcb985efd20c62a92f4e2bc43160f259cdce47156d8dd7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bc4f16ef5e76cffa5259b60295a53324284600efa5582f7d65dcedb3c1f32c6bf0a3579959ec6e03fd0501e8eb5de2f0b024e2e74dadb40bc4b1d0b120c87d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e400fbfcc9d63b964071b5cea138fad4f66c9c779099d50572869befaea47d65e5a728d1988c8354c96514e193c0cc9379a253e2c30729d5b63ed66ee3c22951"} 09:40:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:40:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:40:54 INFO - Contents: 09:40:54 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5bea600e510d8c3650dcd230d8951dcf1c53af79e2e33a8483fed6ef370d8648e4c8c9c8bdf7f76f1fd15ee2521a38c7f6f95fb5552e6764a8de35351029df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/031b0df8ca8ec727ff44ecd193f15c2b9444ba776e8c21c875e717df231d7556ac5dde5d46cb4887f0dcb985efd20c62a92f4e2bc43160f259cdce47156d8dd7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bc4f16ef5e76cffa5259b60295a53324284600efa5582f7d65dcedb3c1f32c6bf0a3579959ec6e03fd0501e8eb5de2f0b024e2e74dadb40bc4b1d0b120c87d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e400fbfcc9d63b964071b5cea138fad4f66c9c779099d50572869befaea47d65e5a728d1988c8354c96514e193c0cc9379a253e2c30729d5b63ed66ee3c22951"} 09:40:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:40:54 INFO - Copying logs to upload dir... 09:40:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:40:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.765038 ========= master_lag: -0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-06-03 09:40:54.926674) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-03 09:40:54.931682) ========= 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-1496506233.647208-347624966 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/a5bea600e510d8c3650dcd230d8951dcf1c53af79e2e33a8483fed6ef370d8648e4c8c9c8bdf7f76f1fd15ee2521a38c7f6f95fb5552e6764a8de35351029df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/031b0df8ca8ec727ff44ecd193f15c2b9444ba776e8c21c875e717df231d7556ac5dde5d46cb4887f0dcb985efd20c62a92f4e2bc43160f259cdce47156d8dd7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bc4f16ef5e76cffa5259b60295a53324284600efa5582f7d65dcedb3c1f32c6bf0a3579959ec6e03fd0501e8eb5de2f0b024e2e74dadb40bc4b1d0b120c87d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e400fbfcc9d63b964071b5cea138fad4f66c9c779099d50572869befaea47d65e5a728d1988c8354c96514e193c0cc9379a253e2c30729d5b63ed66ee3c22951"} build_url:https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/UGE2iFDrT826tnCCpYLODA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5bea600e510d8c3650dcd230d8951dcf1c53af79e2e33a8483fed6ef370d8648e4c8c9c8bdf7f76f1fd15ee2521a38c7f6f95fb5552e6764a8de35351029df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/031b0df8ca8ec727ff44ecd193f15c2b9444ba776e8c21c875e717df231d7556ac5dde5d46cb4887f0dcb985efd20c62a92f4e2bc43160f259cdce47156d8dd7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bc4f16ef5e76cffa5259b60295a53324284600efa5582f7d65dcedb3c1f32c6bf0a3579959ec6e03fd0501e8eb5de2f0b024e2e74dadb40bc4b1d0b120c87d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e400fbfcc9d63b964071b5cea138fad4f66c9c779099d50572869befaea47d65e5a728d1988c8354c96514e193c0cc9379a253e2c30729d5b63ed66ee3c22951"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-03 09:40:54.958943) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 09:40:54.959282) ========= 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-1496506233.647208-347624966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-03 09:40:55.039110) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-03 09:40:55.042445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-03 09:40:55.042738) ========= ========= Total master_lag: 0.07 =========