builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1498581366.29 results: success (0) revision: f4e52135d9bdc6ce98bb37b450021445aed894ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-27 09:36:06.292211) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-27 09:36:06.292675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-27 09:36:06.292969) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-27 09:36:06.370267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-27 09:36:06.370665) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-27 09:36:07-- 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% 42.8M=0s 2017-06-27 09:36:07 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097042 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-27 09:36:06.480473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-27 09:36:06.480792) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022705 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-27 09:36:06.532665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-27 09:36:06.533011) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f4e52135d9bdc6ce98bb37b450021445aed894ce --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 f4e52135d9bdc6ce98bb37b450021445aed894ce --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=9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-27 09:36:08,069 truncating revision to first 12 chars 2017-06-27 09:36:08,069 Setting DEBUG logging. 2017-06-27 09:36:08,069 attempt 1/10 2017-06-27 09:36:08,069 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f4e52135d9bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-27 09:36:09,223 unpacking tar archive at: mozilla-central-f4e52135d9bd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.497323 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-27 09:36:08.042617) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-27 09:36:08.044989) ========= script_repo_revision: f4e52135d9bdc6ce98bb37b450021445aed894ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-27 09:36:08.045369) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-27 09:36:08.045627) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-27 09:36:08.054787) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-06-27 09:36:08.055153) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:36:09 INFO - MultiFileLogger online at 20170627 09:36:09 in /builds/slave/test 09:36:09 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:36:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:36:09 INFO - {'append_to_log': False, 09:36:09 INFO - 'base_work_dir': '/builds/slave/test', 09:36:09 INFO - 'blob_upload_branch': 'Firefox', 09:36:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:36:09 INFO - 'branch': 'Firefox', 09:36:09 INFO - 'buildbot_json_path': 'buildprops.json', 09:36:09 INFO - 'config_files': ('talos/linux_config.py',), 09:36:09 INFO - 'default_actions': ('clobber', 09:36:09 INFO - 'read-buildbot-config', 09:36:09 INFO - 'download-and-extract', 09:36:09 INFO - 'populate-webroot', 09:36:09 INFO - 'create-virtualenv', 09:36:09 INFO - 'install', 09:36:09 INFO - 'setup-mitmproxy', 09:36:09 INFO - 'run-tests'), 09:36:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:36:09 INFO - 'download_minidump_stackwalk': True, 09:36:09 INFO - 'download_symbols': 'ondemand', 09:36:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:36:09 INFO - 'tooltool.py': '/tools/tooltool.py', 09:36:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:36:09 INFO - '/tools/misc-python/virtualenv.py')}, 09:36:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:36:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:36:09 INFO - 'gecko_profile': False, 09:36:09 INFO - 'gecko_profile_interval': 0, 09:36:09 INFO - 'installer_path': 'installer.exe', 09:36:09 INFO - 'log_level': 'info', 09:36:09 INFO - 'log_name': 'talos', 09:36:09 INFO - 'log_to_console': True, 09:36:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:36:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:36:09 INFO - 'opt_config_files': (), 09:36:09 INFO - 'pip_index': False, 09:36:09 INFO - 'suite': 'dromaeojs-e10s', 09:36:09 INFO - 'system_bits': '32', 09:36:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:36:09 INFO - 'title': 'talos-linux64-ix-040', 09:36:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:36:09 INFO - 'use_talos_json': True, 09:36:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:36:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:36:09 INFO - 'work_dir': 'build'} 09:36:09 INFO - [mozharness: 2017-06-27 16:36:09.693851Z] Running clobber step. 09:36:09 INFO - Running pre-action listener: _resource_record_pre_action 09:36:09 INFO - Running main action method: clobber 09:36:09 INFO - rmtree: /builds/slave/test/build 09:36:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:36:10 INFO - Running post-action listener: _resource_record_post_action 09:36:10 INFO - [mozharness: 2017-06-27 16:36:10.724765Z] Finished clobber step (success) 09:36:10 INFO - [mozharness: 2017-06-27 16:36:10.724866Z] Running read-buildbot-config step. 09:36:10 INFO - Running pre-action listener: _resource_record_pre_action 09:36:10 INFO - Running main action method: read_buildbot_config 09:36:10 INFO - Using buildbot properties: 09:36:10 INFO - { 09:36:10 INFO - "project": "", 09:36:10 INFO - "product": "firefox", 09:36:10 INFO - "who": "ffxbld@noreply.mozilla.org", 09:36:10 INFO - "installer_path": "public/build/target.tar.bz2", 09:36:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 09:36:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:36:10 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 09:36:10 INFO - "stage_platform": "linux64-stylo", 09:36:10 INFO - "basedir": "/builds/slave/test", 09:36:10 INFO - "buildnumber": 177, 09:36:10 INFO - "platform": "ubuntu64_hw_stylo", 09:36:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:36:10 INFO - "slavebuilddir": "test", 09:36:10 INFO - "taskId": "XppJ8FuuRrKnj23qAuZwKg", 09:36:10 INFO - "branch": "mozilla-central", 09:36:10 INFO - "script_repo_revision": "production", 09:36:10 INFO - "revision": "f4e52135d9bdc6ce98bb37b450021445aed894ce", 09:36:10 INFO - "slavename": "talos-linux64-ix-040", 09:36:10 INFO - "repo_path": "mozilla-central" 09:36:10 INFO - } 09:36:10 INFO - Finding installer, test and symbols from parent task. 09:36:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XppJ8FuuRrKnj23qAuZwKg'}, attempt #1 09:36:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XppJ8FuuRrKnj23qAuZwKg'}, attempt #1 09:36:11 INFO - Task dependencies: ebqFHG3gQ76gsR6ghI9XMQ 09:36:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ'}, attempt #1 09:36:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.tar.bz2 09:36:12 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/test_packages.json 09:36:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.crashreporter-symbols.zip 09:36:12 INFO - Running post-action listener: _resource_record_post_action 09:36:12 INFO - [mozharness: 2017-06-27 16:36:12.082411Z] Finished read-buildbot-config step (success) 09:36:12 INFO - [mozharness: 2017-06-27 16:36:12.082628Z] Running download-and-extract step. 09:36:12 INFO - Running pre-action listener: _resource_record_pre_action 09:36:12 INFO - Running main action method: download_and_extract 09:36:12 INFO - mkdir: /builds/slave/test/build/tests 09:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:12 INFO - trying https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.test_packages.json 09:36:12 INFO - Downloading https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:36:12 INFO - Downloaded 989 bytes. 09:36:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:36:12 INFO - Using the following test package requirements: 09:36:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:36:12 INFO - u'common': [u'target.common.tests.zip'], 09:36:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:36:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:36:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:36:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:36:12 INFO - u'mozbase': [u'target.common.tests.zip'], 09:36:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:36:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:36:12 INFO - u'web-platform': [u'target.common.tests.zip', 09:36:12 INFO - u'target.web-platform.tests.tar.gz'], 09:36:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:36:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:36:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.common.tests.zip 09:36:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:36:12 INFO - Fetch https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.common.tests.zip into memory 09:36:13 INFO - Content-Length response header: 67750940 09:36:13 INFO - Bytes received: 67750940 09:36:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:36:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.common.tests.zip 09:36:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:36:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.common.tests.zip into memory 09:36:26 INFO - Content-Length response header: 67750940 09:36:26 INFO - Bytes received: 67750940 09:36:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.talos.tests.zip 09:36:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:36:38 INFO - Fetch https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.talos.tests.zip into memory 09:36:38 INFO - Content-Length response header: 14442527 09:36:38 INFO - Bytes received: 14442527 09:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:39 INFO - trying https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.tar.bz2 09:36:39 INFO - Downloading https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:36:40 INFO - Downloaded 61801028 bytes. 09:36:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.tar.bz2 09:36:40 INFO - mkdir: /builds/slave/test/properties 09:36:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:36:40 INFO - Writing to file /builds/slave/test/properties/build_url 09:36:40 INFO - Contents: 09:36:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.tar.bz2 09:36:40 INFO - Running post-action listener: _resource_record_post_action 09:36:40 INFO - Running post-action listener: set_extra_try_arguments 09:36:40 INFO - [mozharness: 2017-06-27 16:36:40.310491Z] Finished download-and-extract step (success) 09:36:40 INFO - [mozharness: 2017-06-27 16:36:40.310587Z] Running populate-webroot step. 09:36:40 INFO - Running pre-action listener: _resource_record_pre_action 09:36:40 INFO - Running main action method: populate_webroot 09:36:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:36:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:36:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:36:40 INFO - '--tppagecycles', 09:36:40 INFO - '7'], 09:36:40 INFO - 'tests': ['tsvgm']}}, 09:36:40 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:36:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:36:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:36:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:36:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:36:40 INFO - 'talos_options': ['--disable-e10s'], 09:36:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:36:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:36:40 INFO - 'talos_options': ['--disable-e10s'], 09:36:40 INFO - 'tests': ['damp', 'tps']}, 09:36:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:36:40 INFO - 'tests': ['damp', 'tps']}, 09:36:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:36:40 INFO - 'tests': ['dromaeo_dom']}, 09:36:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:36:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:36:40 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:36:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:36:40 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:36:40 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:36:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:36:40 INFO - 'tests': ['a11yr', 09:36:40 INFO - 'ts_paint', 09:36:40 INFO - 'tpaint', 09:36:40 INFO - 'sessionrestore', 09:36:40 INFO - 'sessionrestore_no_auto_restore', 09:36:40 INFO - 'tabpaint']}, 09:36:40 INFO - 'other-e10s': {'tests': ['a11yr', 09:36:40 INFO - 'ts_paint', 09:36:40 INFO - 'tpaint', 09:36:40 INFO - 'sessionrestore', 09:36:40 INFO - 'sessionrestore_no_auto_restore', 09:36:40 INFO - 'tabpaint']}, 09:36:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:36:40 INFO - 'ts_paint', 09:36:40 INFO - 'tpaint', 09:36:40 INFO - 'sessionrestore', 09:36:40 INFO - 'sessionrestore_no_auto_restore', 09:36:40 INFO - 'tabpaint']}, 09:36:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:36:40 INFO - 'ts_paint', 09:36:40 INFO - 'tpaint', 09:36:40 INFO - 'sessionrestore', 09:36:40 INFO - 'sessionrestore_no_auto_restore', 09:36:40 INFO - 'tabpaint']}, 09:36:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:36:40 INFO - 'tests': ['a11yr', 09:36:40 INFO - 'ts_paint', 09:36:40 INFO - 'tpaint', 09:36:40 INFO - 'sessionrestore', 09:36:40 INFO - 'sessionrestore_no_auto_restore', 09:36:40 INFO - 'tabpaint']}, 09:36:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:36:40 INFO - 'tests': ['a11yr', 09:36:40 INFO - 'ts_paint', 09:36:40 INFO - 'tpaint', 09:36:40 INFO - 'sessionrestore', 09:36:40 INFO - 'sessionrestore_no_auto_restore', 09:36:40 INFO - 'tabpaint']}, 09:36:40 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:36:40 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:36:40 INFO - 'bloom_basic_ref']}, 09:36:40 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:36:40 INFO - 'talos_options': ['--mitmproxy', 09:36:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:36:40 INFO - '--firstNonBlankPaint'], 09:36:40 INFO - 'tests': ['quantum_pageload_google', 09:36:40 INFO - 'quantum_pageload_youtube', 09:36:40 INFO - 'quantum_pageload_amazon', 09:36:40 INFO - 'quantum_pageload_facebook']}, 09:36:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:36:40 INFO - 'tests': ['tsvgx', 09:36:40 INFO - 'tsvgr_opacity', 09:36:40 INFO - 'tart', 09:36:40 INFO - 'tscrollx', 09:36:40 INFO - 'cart', 09:36:40 INFO - 'tsvg_static']}, 09:36:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:36:40 INFO - 'tsvgr_opacity', 09:36:40 INFO - 'tart', 09:36:40 INFO - 'tscrollx', 09:36:40 INFO - 'cart', 09:36:40 INFO - 'tsvg_static']}, 09:36:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:36:40 INFO - 'talos_options': ['--disable-e10s'], 09:36:40 INFO - 'tests': ['tp5o']}, 09:36:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:36:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:36:40 INFO - 'talos_options': ['--disable-e10s', 09:36:40 INFO - '--xperf_path', 09:36:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:40 INFO - 'tests': ['tp5n']}, 09:36:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:36:40 INFO - 'talos_options': ['--xperf_path', 09:36:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:40 INFO - 'tests': ['tp5n']}}, 09:36:40 INFO - 'talos.zip': {'path': '', 09:36:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:36:40 INFO - Running post-action listener: _resource_record_post_action 09:36:40 INFO - [mozharness: 2017-06-27 16:36:40.325308Z] Finished populate-webroot step (success) 09:36:40 INFO - [mozharness: 2017-06-27 16:36:40.325397Z] Running create-virtualenv step. 09:36:40 INFO - Running pre-action listener: _resource_record_pre_action 09:36:40 INFO - Running main action method: create_virtualenv 09:36:40 INFO - Creating virtualenv /builds/slave/test/build/venv 09:36:40 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:36:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:36:40 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:36:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:36:40 INFO - Using real prefix '/usr' 09:36:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:36:40 INFO - Installing distribute.............................................................................................................................................................................................done. 09:36:42 INFO - Installing pip.................done. 09:36:42 INFO - Return code: 0 09:36:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:36:43 INFO - Reading from file tmpfile_stdout 09:36:43 INFO - Output received: 09:36:43 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:36:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:43 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 0x143e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba140>, '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 0x17baa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17baed0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', '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:36:43 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:36:43 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:36:43 INFO - Using env: {'DISPLAY': ':0', 09:36:43 INFO - 'HOME': '/home/cltbld', 09:36:43 INFO - 'LANG': 'en_US.UTF-8', 09:36:43 INFO - 'LANGUAGE': 'en_US:en', 09:36:43 INFO - 'LOGNAME': 'cltbld', 09:36:43 INFO - 'MAIL': '/var/mail/cltbld', 09:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:43 INFO - 'MOZ_NO_REMOTE': '1', 09:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:43 INFO - 'NO_EM_RESTART': '1', 09:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:43 INFO - 'PWD': '/builds/slave/test', 09:36:43 INFO - 'SHELL': '/bin/bash', 09:36:43 INFO - 'SHLVL': '1', 09:36:43 INFO - 'TERM': 'linux', 09:36:43 INFO - 'TMOUT': '86400', 09:36:43 INFO - 'USER': 'cltbld', 09:36:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', 09:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:43 INFO - '_': '/tools/buildbot/bin/python'} 09:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:43 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:36:43 INFO - Cleaning up... 09:36:43 INFO - Return code: 0 09:36:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:43 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 0x143e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba140>, '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 0x17baa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17baed0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', '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:36:43 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:36:43 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:36:43 INFO - Using env: {'DISPLAY': ':0', 09:36:43 INFO - 'HOME': '/home/cltbld', 09:36:43 INFO - 'LANG': 'en_US.UTF-8', 09:36:43 INFO - 'LANGUAGE': 'en_US:en', 09:36:43 INFO - 'LOGNAME': 'cltbld', 09:36:43 INFO - 'MAIL': '/var/mail/cltbld', 09:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:43 INFO - 'MOZ_NO_REMOTE': '1', 09:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:43 INFO - 'NO_EM_RESTART': '1', 09:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:43 INFO - 'PWD': '/builds/slave/test', 09:36:43 INFO - 'SHELL': '/bin/bash', 09:36:43 INFO - 'SHLVL': '1', 09:36:43 INFO - 'TERM': 'linux', 09:36:43 INFO - 'TMOUT': '86400', 09:36:43 INFO - 'USER': 'cltbld', 09:36:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', 09:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:43 INFO - '_': '/tools/buildbot/bin/python'} 09:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:43 INFO - Downloading/unpacking psutil>=3.1.1 09:36: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:36: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:36: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:36: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:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:36:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:44 INFO - Installing collected packages: psutil 09:36:44 INFO - Running setup.py install for psutil 09:36:44 INFO - building 'psutil._psutil_linux' extension 09:36:44 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:36:44 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:36:45 INFO - building 'psutil._psutil_posix' extension 09:36:45 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:36:45 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:36:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:45 INFO - Successfully installed psutil 09:36:45 INFO - Cleaning up... 09:36:45 INFO - Return code: 0 09:36:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:36:45 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:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:45 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:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:45 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 0x143e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba140>, '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 0x17baa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17baed0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', '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:36:45 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:36:45 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:36:45 INFO - Using env: {'DISPLAY': ':0', 09:36:45 INFO - 'HOME': '/home/cltbld', 09:36:45 INFO - 'LANG': 'en_US.UTF-8', 09:36:45 INFO - 'LANGUAGE': 'en_US:en', 09:36:45 INFO - 'LOGNAME': 'cltbld', 09:36:45 INFO - 'MAIL': '/var/mail/cltbld', 09:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:45 INFO - 'MOZ_NO_REMOTE': '1', 09:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:45 INFO - 'NO_EM_RESTART': '1', 09:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:45 INFO - 'PWD': '/builds/slave/test', 09:36:45 INFO - 'SHELL': '/bin/bash', 09:36:45 INFO - 'SHLVL': '1', 09:36:45 INFO - 'TERM': 'linux', 09:36:45 INFO - 'TMOUT': '86400', 09:36:45 INFO - 'USER': 'cltbld', 09:36:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', 09:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:45 INFO - '_': '/tools/buildbot/bin/python'} 09:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:36:45 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:36:45 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:36:45 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:36:45 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:36:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:36:46 INFO - Installing collected packages: mozsystemmonitor 09:36:46 INFO - Running setup.py install for mozsystemmonitor 09:36:46 INFO - Successfully installed mozsystemmonitor 09:36:46 INFO - Cleaning up... 09:36:46 INFO - Return code: 0 09:36:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:36:46 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:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:46 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:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:46 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 0x143e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba140>, '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 0x17baa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17baed0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', '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:36:46 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:36:46 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:36:46 INFO - Using env: {'DISPLAY': ':0', 09:36:46 INFO - 'HOME': '/home/cltbld', 09:36:46 INFO - 'LANG': 'en_US.UTF-8', 09:36:46 INFO - 'LANGUAGE': 'en_US:en', 09:36:46 INFO - 'LOGNAME': 'cltbld', 09:36:46 INFO - 'MAIL': '/var/mail/cltbld', 09:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:46 INFO - 'MOZ_NO_REMOTE': '1', 09:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:46 INFO - 'NO_EM_RESTART': '1', 09:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:46 INFO - 'PWD': '/builds/slave/test', 09:36:46 INFO - 'SHELL': '/bin/bash', 09:36:46 INFO - 'SHLVL': '1', 09:36:46 INFO - 'TERM': 'linux', 09:36:46 INFO - 'TMOUT': '86400', 09:36:46 INFO - 'USER': 'cltbld', 09:36:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', 09:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:46 INFO - '_': '/tools/buildbot/bin/python'} 09:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:46 INFO - Downloading/unpacking jsonschema==2.5.1 09:36:46 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:36:46 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:36:46 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:36:46 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:36:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:36:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:48 INFO - Downloading functools32-3.2.3-2.tar.gz 09:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:36:48 INFO - warning: no files found matching '*.txt' 09:36:48 INFO - no previously-included directories found matching 'build' 09:36:48 INFO - no previously-included directories found matching 'dist' 09:36:48 INFO - no previously-included directories found matching '.git*' 09:36:48 INFO - Installing collected packages: jsonschema, functools32 09:36:48 INFO - Running setup.py install for functools32 09:36:48 INFO - warning: no files found matching '*.txt' 09:36:48 INFO - no previously-included directories found matching 'build' 09:36:48 INFO - no previously-included directories found matching 'dist' 09:36:48 INFO - no previously-included directories found matching '.git*' 09:36:48 INFO - Successfully installed jsonschema functools32 09:36:48 INFO - Cleaning up... 09:36:48 INFO - Return code: 0 09:36:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:36:48 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:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:48 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:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:48 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 0x143e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba140>, '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 0x17baa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17baed0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', '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:36:48 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:36:48 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:36:48 INFO - Using env: {'DISPLAY': ':0', 09:36:48 INFO - 'HOME': '/home/cltbld', 09:36:48 INFO - 'LANG': 'en_US.UTF-8', 09:36:48 INFO - 'LANGUAGE': 'en_US:en', 09:36:48 INFO - 'LOGNAME': 'cltbld', 09:36:48 INFO - 'MAIL': '/var/mail/cltbld', 09:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:48 INFO - 'MOZ_NO_REMOTE': '1', 09:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:48 INFO - 'NO_EM_RESTART': '1', 09:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:48 INFO - 'PWD': '/builds/slave/test', 09:36:48 INFO - 'SHELL': '/bin/bash', 09:36:48 INFO - 'SHLVL': '1', 09:36:48 INFO - 'TERM': 'linux', 09:36:48 INFO - 'TMOUT': '86400', 09:36:48 INFO - 'USER': 'cltbld', 09:36:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', 09:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:48 INFO - '_': '/tools/buildbot/bin/python'} 09:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:36:48 INFO - Cleaning up... 09:36:48 INFO - Return code: 0 09:36:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:36:48 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:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:48 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:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:48 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 0x143e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba140>, '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 0x17baa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17baed0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', '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:36:48 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:36:48 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:36:48 INFO - Using env: {'DISPLAY': ':0', 09:36:48 INFO - 'HOME': '/home/cltbld', 09:36:48 INFO - 'LANG': 'en_US.UTF-8', 09:36:48 INFO - 'LANGUAGE': 'en_US:en', 09:36:48 INFO - 'LOGNAME': 'cltbld', 09:36:48 INFO - 'MAIL': '/var/mail/cltbld', 09:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:48 INFO - 'MOZ_NO_REMOTE': '1', 09:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:48 INFO - 'NO_EM_RESTART': '1', 09:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:48 INFO - 'PWD': '/builds/slave/test', 09:36:48 INFO - 'SHELL': '/bin/bash', 09:36:48 INFO - 'SHLVL': '1', 09:36:48 INFO - 'TERM': 'linux', 09:36:48 INFO - 'TMOUT': '86400', 09:36:48 INFO - 'USER': 'cltbld', 09:36:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', 09:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:48 INFO - '_': '/tools/buildbot/bin/python'} 09:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:48 INFO - Downloading/unpacking blobuploader==1.2.4 09:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:49 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36: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:36: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:36: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:36: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:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:36:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:36: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:36: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:36: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:36: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:36:50 INFO - Downloading docopt-0.6.1.tar.gz 09:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:36:50 INFO - Installing collected packages: blobuploader, requests, docopt 09:36:50 INFO - Running setup.py install for blobuploader 09:36:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:36:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:36:50 INFO - Running setup.py install for requests 09:36:50 INFO - Running setup.py install for docopt 09:36:51 INFO - Successfully installed blobuploader requests docopt 09:36:51 INFO - Cleaning up... 09:36:51 INFO - Return code: 0 09:36:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:51 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 0x143e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba140>, '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 0x17baa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17baed0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', '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:36:51 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:36:51 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:36:51 INFO - Using env: {'DISPLAY': ':0', 09:36:51 INFO - 'HOME': '/home/cltbld', 09:36:51 INFO - 'LANG': 'en_US.UTF-8', 09:36:51 INFO - 'LANGUAGE': 'en_US:en', 09:36:51 INFO - 'LOGNAME': 'cltbld', 09:36:51 INFO - 'MAIL': '/var/mail/cltbld', 09:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:51 INFO - 'MOZ_NO_REMOTE': '1', 09:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:51 INFO - 'NO_EM_RESTART': '1', 09:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:51 INFO - 'PWD': '/builds/slave/test', 09:36:51 INFO - 'SHELL': '/bin/bash', 09:36:51 INFO - 'SHLVL': '1', 09:36:51 INFO - 'TERM': 'linux', 09:36:51 INFO - 'TMOUT': '86400', 09:36:51 INFO - 'USER': 'cltbld', 09:36:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', 09:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:51 INFO - '_': '/tools/buildbot/bin/python'} 09:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:51 INFO - Running setup.py (path:/tmp/pip-d91cia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:51 INFO - Running setup.py (path:/tmp/pip-olMMZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:51 INFO - Running setup.py (path:/tmp/pip-yXupBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:51 INFO - Running setup.py (path:/tmp/pip-BB7yFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:51 INFO - Running setup.py (path:/tmp/pip-iDccnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:51 INFO - Running setup.py (path:/tmp/pip-sArSbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:51 INFO - Running setup.py (path:/tmp/pip-pXNCYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:51 INFO - Running setup.py (path:/tmp/pip-0tDE3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:51 INFO - Running setup.py (path:/tmp/pip-GlcHea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:51 INFO - Running setup.py (path:/tmp/pip-bE_QNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:52 INFO - Running setup.py (path:/tmp/pip-wsma6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:52 INFO - Running setup.py (path:/tmp/pip-rLrGCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:52 INFO - Running setup.py (path:/tmp/pip-Z7w_o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:52 INFO - Running setup.py (path:/tmp/pip-ckZ3Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:52 INFO - Running setup.py (path:/tmp/pip-3w77b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:52 INFO - Running setup.py (path:/tmp/pip-WB8NJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:52 INFO - Running setup.py (path:/tmp/pip-bdMuzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:52 INFO - Running setup.py install for manifestparser 09:36:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:36:52 INFO - Running setup.py install for mozcrash 09:36:52 INFO - Running setup.py install for mozdebug 09:36:52 INFO - Running setup.py install for mozdevice 09:36:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:36:52 INFO - Running setup.py install for mozfile 09:36:53 INFO - Running setup.py install for mozhttpd 09:36:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:36:53 INFO - Running setup.py install for mozinfo 09:36:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:36:53 INFO - Running setup.py install for mozInstall 09:36:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:36:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:36:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:36:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:36:53 INFO - Running setup.py install for mozleak 09:36:53 INFO - Running setup.py install for mozlog 09:36:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:36:53 INFO - Running setup.py install for moznetwork 09:36:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:36:53 INFO - Running setup.py install for mozprocess 09:36:53 INFO - Running setup.py install for mozprofile 09:36:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:36:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:36:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:36:53 INFO - Running setup.py install for mozrunner 09:36:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:36:53 INFO - Running setup.py install for mozscreenshot 09:36:54 INFO - Running setup.py install for moztest 09:36:54 INFO - Running setup.py install for mozversion 09:36:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:36:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:54 INFO - Cleaning up... 09:36:54 INFO - Return code: 0 09:36:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:54 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 0x143e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba140>, '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 0x17baa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17baed0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', '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:36:54 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:36:54 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:36:54 INFO - Using env: {'DISPLAY': ':0', 09:36:54 INFO - 'HOME': '/home/cltbld', 09:36:54 INFO - 'LANG': 'en_US.UTF-8', 09:36:54 INFO - 'LANGUAGE': 'en_US:en', 09:36:54 INFO - 'LOGNAME': 'cltbld', 09:36:54 INFO - 'MAIL': '/var/mail/cltbld', 09:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:54 INFO - 'MOZ_NO_REMOTE': '1', 09:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:54 INFO - 'NO_EM_RESTART': '1', 09:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:54 INFO - 'PWD': '/builds/slave/test', 09:36:54 INFO - 'SHELL': '/bin/bash', 09:36:54 INFO - 'SHLVL': '1', 09:36:54 INFO - 'TERM': 'linux', 09:36:54 INFO - 'TMOUT': '86400', 09:36:54 INFO - 'USER': 'cltbld', 09:36:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', 09:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:54 INFO - '_': '/tools/buildbot/bin/python'} 09:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:54 INFO - Running setup.py (path:/tmp/pip-jv7dOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:54 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:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:54 INFO - Running setup.py (path:/tmp/pip-AGH56D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:54 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:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:54 INFO - Running setup.py (path:/tmp/pip-W4dOTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:54 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:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:54 INFO - Running setup.py (path:/tmp/pip-e8Fc8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:54 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:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:54 INFO - Running setup.py (path:/tmp/pip-ydT1lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:54 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:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:54 INFO - Running setup.py (path:/tmp/pip-7bNn9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:54 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:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:54 INFO - Running setup.py (path:/tmp/pip-lzZDTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:55 INFO - Running setup.py (path:/tmp/pip-7TZhv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:55 INFO - Running setup.py (path:/tmp/pip-MpWvdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:55 INFO - Running setup.py (path:/tmp/pip-R1oO1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:55 INFO - Running setup.py (path:/tmp/pip-pmbxpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:55 INFO - Running setup.py (path:/tmp/pip-jIqcpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:55 INFO - Running setup.py (path:/tmp/pip-lxfw7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:55 INFO - Running setup.py (path:/tmp/pip-UNbvp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:55 INFO - Running setup.py (path:/tmp/pip-GRS9Vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:55 INFO - Running setup.py (path:/tmp/pip-PHmNPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:55 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:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:55 INFO - Running setup.py (path:/tmp/pip-DpVY7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:55 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:36:55 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:36:55 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:36:55 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:36:55 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:36:55 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:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:36:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:55 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:36:55 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:36:55 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:36:55 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:36:56 INFO - Downloading blessings-1.6.tar.gz 09:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:56 INFO - Installing collected packages: blessings 09:36:56 INFO - Running setup.py install for blessings 09:36:57 INFO - Successfully installed blessings 09:36:57 INFO - Cleaning up... 09:36:57 INFO - Return code: 0 09:36:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:57 INFO - Reading from file tmpfile_stdout 09:36:57 INFO - Current package versions: 09:36:57 INFO - argparse == 1.2.1 09:36:57 INFO - blessings == 1.6 09:36:57 INFO - blobuploader == 1.2.4 09:36:57 INFO - docopt == 0.6.1 09:36:57 INFO - functools32 == 3.2.3-2 09:36:57 INFO - jsonschema == 2.5.1 09:36:57 INFO - manifestparser == 1.1 09:36:57 INFO - mozInstall == 1.13 09:36:57 INFO - mozcrash == 1.0 09:36:57 INFO - mozdebug == 0.1 09:36:57 INFO - mozdevice == 0.51 09:36:57 INFO - mozfile == 1.2 09:36:57 INFO - mozhttpd == 0.7 09:36:57 INFO - mozinfo == 0.10 09:36:57 INFO - mozleak == 0.1 09:36:57 INFO - mozlog == 3.4 09:36:57 INFO - moznetwork == 0.27 09:36:57 INFO - mozprocess == 0.25 09:36:57 INFO - mozprofile == 0.28 09:36:57 INFO - mozrunner == 6.13 09:36:57 INFO - mozscreenshot == 0.1 09:36:57 INFO - mozsystemmonitor == 0.3 09:36:57 INFO - moztest == 0.8 09:36:57 INFO - mozversion == 1.4 09:36:57 INFO - psutil == 3.1.1 09:36:57 INFO - requests == 1.2.3 09:36:57 INFO - wsgiref == 0.1.2 09:36:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:57 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 0x143e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba140>, '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 0x17baa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17baed0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', '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:36:57 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:36:57 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:36:57 INFO - Using env: {'DISPLAY': ':0', 09:36:57 INFO - 'HOME': '/home/cltbld', 09:36:57 INFO - 'LANG': 'en_US.UTF-8', 09:36:57 INFO - 'LANGUAGE': 'en_US:en', 09:36:57 INFO - 'LOGNAME': 'cltbld', 09:36:57 INFO - 'MAIL': '/var/mail/cltbld', 09:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:57 INFO - 'MOZ_NO_REMOTE': '1', 09:36:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:57 INFO - 'NO_EM_RESTART': '1', 09:36:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:57 INFO - 'PWD': '/builds/slave/test', 09:36:57 INFO - 'SHELL': '/bin/bash', 09:36:57 INFO - 'SHLVL': '1', 09:36:57 INFO - 'TERM': 'linux', 09:36:57 INFO - 'TMOUT': '86400', 09:36:57 INFO - 'USER': 'cltbld', 09:36:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', 09:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:57 INFO - '_': '/tools/buildbot/bin/python'} 09:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:58 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:36:58 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:36:58 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:36:58 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:36:58 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:36:58 INFO - Installing collected packages: marionette-driver 09:36:58 INFO - Running setup.py install for marionette-driver 09:36:58 INFO - Successfully installed marionette-driver 09:36:58 INFO - Cleaning up... 09:36:58 INFO - Return code: 0 09:36:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:36:58 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:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:58 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:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:58 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 0x143e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba140>, '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 0x17baa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17baed0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', '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:36:58 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:36:58 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:36:58 INFO - Using env: {'DISPLAY': ':0', 09:36:58 INFO - 'HOME': '/home/cltbld', 09:36:58 INFO - 'LANG': 'en_US.UTF-8', 09:36:58 INFO - 'LANGUAGE': 'en_US:en', 09:36:58 INFO - 'LOGNAME': 'cltbld', 09:36:58 INFO - 'MAIL': '/var/mail/cltbld', 09:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:58 INFO - 'MOZ_NO_REMOTE': '1', 09:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:58 INFO - 'NO_EM_RESTART': '1', 09:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:58 INFO - 'PWD': '/builds/slave/test', 09:36:58 INFO - 'SHELL': '/bin/bash', 09:36:58 INFO - 'SHLVL': '1', 09:36:58 INFO - 'TERM': 'linux', 09:36:58 INFO - 'TMOUT': '86400', 09:36:58 INFO - 'USER': 'cltbld', 09:36:58 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', 09:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:58 INFO - '_': '/tools/buildbot/bin/python'} 09:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:36:59 INFO - Cleaning up... 09:36:59 INFO - Return code: 0 09:36:59 INFO - Running post-action listener: _resource_record_post_action 09:36:59 INFO - Running post-action listener: _start_resource_monitoring 09:36:59 INFO - Starting resource monitoring. 09:36:59 INFO - [mozharness: 2017-06-27 16:36:59.127331Z] Finished create-virtualenv step (success) 09:36:59 INFO - [mozharness: 2017-06-27 16:36:59.127848Z] Running install step. 09:36:59 INFO - Running pre-action listener: _resource_record_pre_action 09:36:59 INFO - Running main action method: install 09:36:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:59 INFO - Reading from file tmpfile_stdout 09:36:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:36:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:36:59 INFO - Reading from file tmpfile_stdout 09:36:59 INFO - Output received: 09:36:59 INFO - Usage: mozinstall [options] installer 09:36:59 INFO - Options: 09:36:59 INFO - -h, --help show this help message and exit 09:36:59 INFO - -d DEST, --destination=DEST 09:36:59 INFO - Directory to install application into. [default: 09:36:59 INFO - "/builds/slave/test"] 09:36:59 INFO - --app=APP Application being installed. [default: firefox] 09:36:59 INFO - mkdir: /builds/slave/test/build/application 09:36:59 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:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:37:17 INFO - Reading from file tmpfile_stdout 09:37:17 INFO - Output received: 09:37:17 INFO - /builds/slave/test/build/application/firefox/firefox 09:37:17 INFO - Running post-action listener: _resource_record_post_action 09:37:17 INFO - [mozharness: 2017-06-27 16:37:17.442472Z] Finished install step (success) 09:37:17 INFO - [mozharness: 2017-06-27 16:37:17.442619Z] Running setup-mitmproxy step. 09:37:17 INFO - Running pre-action listener: _resource_record_pre_action 09:37:17 INFO - Running main action method: setup_mitmproxy 09:37:17 INFO - Skipping: mitmproxy is not required 09:37:17 INFO - Running post-action listener: _resource_record_post_action 09:37:17 INFO - [mozharness: 2017-06-27 16:37:17.443150Z] Finished setup-mitmproxy step (success) 09:37:17 INFO - [mozharness: 2017-06-27 16:37:17.443251Z] Running run-tests step. 09:37:17 INFO - Running pre-action listener: _resource_record_pre_action 09:37:17 INFO - Running main action method: run_tests 09:37:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:37:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:37:17 INFO - Python 2.7.3 09:37:17 INFO - Return code: 0 09:37:17 INFO - grabbing minidump binary from tooltool 09:37:17 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:37:17 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 0x17ba140>, '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 0x17baa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17baed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:37:17 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:37:17 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:37:17 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:37:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:37:17 INFO - Return code: 0 09:37:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:37:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:37:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:37:17 INFO - ENV: RUST_BACKTRACE is now 1 09:37:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:37:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:37:17 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/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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:37:17 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/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --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:37:17 INFO - Using env: {'DISPLAY': ':0', 09:37:17 INFO - 'HOME': '/home/cltbld', 09:37:17 INFO - 'LANG': 'en_US.UTF-8', 09:37:17 INFO - 'LANGUAGE': 'en_US:en', 09:37:17 INFO - 'LOGNAME': 'cltbld', 09:37:17 INFO - 'MAIL': '/var/mail/cltbld', 09:37:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:37:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:17 INFO - 'MOZ_NO_REMOTE': '1', 09:37:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:17 INFO - 'NO_EM_RESTART': '1', 09:37:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:17 INFO - 'PWD': '/builds/slave/test', 09:37:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:37:17 INFO - 'RUST_BACKTRACE': '1', 09:37:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:37:17 INFO - 'SHELL': '/bin/bash', 09:37:17 INFO - 'SHLVL': '1', 09:37:17 INFO - 'TERM': 'linux', 09:37:17 INFO - 'TMOUT': '86400', 09:37:17 INFO - 'USER': 'cltbld', 09:37:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721', 09:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:17 INFO - '_': '/tools/buildbot/bin/python'} 09:37:17 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/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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:37:17 INFO - mozversion application_buildid: 20170627153913 09:37:17 INFO - mozversion application_changeset: f4e52135d9bdc6ce98bb37b450021445aed894ce 09:37:17 INFO - mozversion application_display_name: Nightly 09:37:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:37:17 INFO - mozversion application_name: Firefox 09:37:17 INFO - mozversion application_remotingname: firefox 09:37:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:37:17 INFO - mozversion application_vendor: Mozilla 09:37:17 INFO - mozversion application_version: 56.0a1 09:37:17 INFO - mozversion platform_buildid: 20170627153913 09:37:17 INFO - mozversion platform_changeset: f4e52135d9bdc6ce98bb37b450021445aed894ce 09:37:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:37:17 INFO - mozversion platform_version: 56.0a1 09:37:17 INFO - using testdate: 1498581437 09:37:17 INFO - actual date: 1498581437 09:37:17 INFO - starting webserver on 'localhost:44462' 09:37:17 INFO - SUITE-START | Running 2 tests 09:37:17 INFO - TEST-START | dromaeo_css 09:37:17 INFO - operating with platform_type : linux_ 09:37:17 INFO - Initialising browser for dromaeo_css test... 09:37:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44462/getInfo.html -profile /tmp/tmpVxihmi/profile 09:37:17 INFO - TEST-INFO | started process 32732 (/builds/slave/test/build/application/firefox/firefox http://localhost:44462/getInfo.html) 09:37:23 INFO - TEST-INFO | 32732: exit 0 09:37:23 INFO - Browser initialized. 09:37:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:37:23 INFO - TEST-INFO | started process 490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVxihmi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:35 INFO - PID 490 | RSS: Main: 172023808 09:37:35 INFO - PID 490 | 09:40:39 INFO - PID 490 | Cycle 1(1): loaded http://localhost:44462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44462/tests/dromaeo/cssquery-ext.html) 09:40:41 INFO - PID 490 | RSS: Main: 179200000 09:40:41 INFO - PID 490 | 09:43:43 INFO - PID 490 | Cycle 1(1): loaded http://localhost:44462/tests/dromaeo/cssquery-ext.html (next: http://localhost:44462/tests/dromaeo/cssquery-jquery.html) 09:43:43 INFO - PID 490 | RSS: Main: 176816128 09:43:43 INFO - PID 490 | 09:46:45 INFO - PID 490 | Cycle 1(1): loaded http://localhost:44462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44462/tests/dromaeo/cssquery-mootools.html) 09:46:46 INFO - PID 490 | RSS: Main: 179638272 09:46:46 INFO - PID 490 | 09:49:47 INFO - PID 490 | Cycle 1(1): loaded http://localhost:44462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44462/tests/dromaeo/cssquery-prototype.html) 09:49:48 INFO - PID 490 | RSS: Main: 177524736 09:49:48 INFO - PID 490 | 09:52:51 INFO - PID 490 | Cycle 1(1): loaded http://localhost:44462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44462/tests/dromaeo/cssquery-yui.html) 09:52:51 INFO - PID 490 | RSS: Main: 177975296 09:52:51 INFO - PID 490 | 09:55:53 INFO - PID 490 | Cycle 1(1): loaded http://localhost:44462/tests/dromaeo/cssquery-yui.html (next: http://localhost:44462/tests/dromaeo/cssquery-dojo.html) 09:55:53 INFO - PID 490 | RSS: Main: 180953088 09:55:53 INFO - PID 490 | 09:55:53 INFO - PID 490 | __start_tp_report 09:55:53 INFO - PID 490 | _x_x_mozilla_page_load 09:55:53 INFO - PID 490 | _x_x_mozilla_page_load_details 09:55:53 INFO - PID 490 | |i|pagename|runs| 09:55:53 INFO - PID 490 | |0;dojo.html;3057.6636569977286;3097.8915737949164;3103.782735208535;3114.937701245975;3142.4029434407475;5915.556333275;5981.551383646222;6003.459688628022;6008.279006519213;6055.0311950088;6046.425589568995;6109.450149486545;6148.1392605035335;6153.2923713772925;6161.229846269216;5657.915131273035;5661;5696.971515142419;5704.058830292996;5766.538676905838;5670;5750.281214848144;5772.595918285721;5774.711264436783;5781.364049954502;5510.8071217507595;5611.663300202001;5640.351359593617;5646.26598542191;5654.067078931971;5427.375851777057;5494.587905907073;5582;5613.494785469327;5637.492625663669;5603.579731520112;5617.241672374218;5619.185218143346;5627.549796016309;5667.206591077253;6087.4521293083835;6125.142480052797;6152.16945712332;6152.661603611799;6161.50707943368;6604.504662150358;6608.339166083353;6625.668716564201;6638.93361066388;6652.667366631649;6424.5502814802985;6499.967500162469;6532.869342613169;6576.901346479759;6708.396244338033;6141.907871381933;6172.6913654318005;6174.6912654368;6218.626882387071;6253;6843;6898.482613803984;6902.827429314308;6910.274421185703;6921.273266307066;6358.237011558643;6435.710393032325;6439.871202575922;6459.935400646027;6474.643894585749;6486.189226346707;6588.96705516479;6605.30644282353;6641.070250164981;6664.8000559983275;6588.044733513614;6625.966870165715;6628.204615446178;6658.3674550917585;6664.86670266592;6409.519286053564;6643.900341494785;6651.467882569383;6665.300143484864;6670.899936500957;5177.171652535576;5269.077911365495;5284.154535274338;5313.229581710708;5325.786968521215;4542.84100056503;4561.498235194126;4579.74811385377;4602.792874320664;4617.976910115495;5751.827445176651;5805.36141024487;5807.622504537191;5820.068788993741;5843.649381037151;6679.539369569286;6689.297623749533;6697.6986035628515;6712.697928593225;6727.798166055026;5713;5742.712864356766;5815.680137592389;5836.708164591753;5852.063669812809;5771.307443106854;5796.304443466811;5827.475527202572;5896.056630939115;5906.202662640489;6427.999999999906;6428.292887782247;6481.4166724994975;6497.382748638872;6509.934900650933;6652.833679157866;6677.43241824431;6681.76613818514;6685.064091027358;6698.7320507179165;6448.838779030374;6449;6466.902996455151;6471;6479.449246814073;6285.465735412541;6402.03969404593;6410.038494225903;6412.39082287182;6529;6600.504962127764;6606.339366063356;6655.600663960178;6663.200415950117;6682.63245521501;6442.871142577029;6458.935410645833;6466.579672321284;6471.288158302677;6481.935180648133;6410.358964103552;6414.134091897721;6420.807375778734;6480.287168411565;6489.091527186292;6133.916185115316;6246.718897649707;6310.242770867525;6315.336889626707;6355.459785918249;6494.090827284279;6510.251321097945;6511.21865376139;6527.477801775752;6537.803865884031;6240.375962403723;6321.841953951004;6325.4939604832425;6330.9237429638;6334.144890439732 09:55:53 INFO - PID 490 | |1;ext.html;776.2741836382979;817.5299202958298;845.742048675154;850.3409857360544;1154.8498695169626;29787;31080.06759797204;40428;41257.38113928294;41309;40953.38569921454;41413.37879931796;41426.58573414265;41448;41523;7506.437017223717;7701;7718.652660630285;7724.536527808322;7731;7439;7592.810179745496;7710.845783084335;7721.189275126115;7737.226277372246;7647;7654.655540500691;7662.463627546074;7672.731454399097;7677.347425468842;7577.318041376275;7607.391408687292;7650.158482566913;7655.043119610049;7685.807854803618;7558.659860306299;7574.31831135195;7602.467827252094;7616.657250423744;7631.503952243086;37449.81275093607;37955.810220948995;37986.62013379886;38078.66724664623;38393.42409863854;3549.8580056797696;3582.1223800168864;3586.193106551031;3594.11944073701;3613.403788374915;29698;29850.70149298501;29895.551566726517;29908;29959.101226963227;3672.6143754905615;3741.625837416264;3742.0644838790304;3779.338615742234;3782.7919464429447;193954;194329.99999999857;194550;194660.026699867;195740;46800.297995529414;46855;46922;47395;47520.28719569209;49251.26123108156;49339.753301233985;49498.50501495011;49523.752381238584;49605.25592116121;15446.5366039019;15470.767938480933;15564.066156030674;15597.142157181464;15605.297761600756;12846;12884.935575322063;12933;12978.740425191443;13002.219866808022;13776.380062897193;13803.930980345034;13861;13891.513797017258;13989.790153147711;5744.310682718101;5747.770089196469;5749.223854779551;5777.653340799566;5804.4195580442465;1001.5442973447064;1001.8397056471075;1003.7641154328727;1024.4263212600817;1030.1655658916302;22292.44268893258;22414.775852241593;22953.08187672508;23013.53972920532;23263.18578849732;1073.2862646340252;1094.8066607397975;1101.2841652925501;1107.9889201108047;1109.938953357557;11933;11946.880531194576;11982.700432489084;12006.279623222634;12243.938780306042;223460;223582;225387;225411;226469;49490.25764613534;49633;49697;49762.50237497651;49778.25332620014;1392.9036799616715;1461.883049356049;1467.625755432358;1468.4933697874217;1484.8292446368805;21199.894000529897;21206.15175392967;21564.568708625426;22300.665490017338;22383.552328953003;35534;35601.82199088988;47962;49047.26429103638;49475.257871131245;203214;203483;203806;204850;205314;29563.26091847721;30035;30056.098317050524;32090;32226.516602250515;40436;42907.35638965481;42912.78543607262;43195.56804432041;43524;30827;31993.520097198096;32028.5195722069;32072.198195045312;32177.839110804296;30904.53643195309;31619.683803161675;31752.523712143873;31893.20266993344;32121.196970075936;33978.15054623654;34669.826650866584;34819.65180348265;35062.64937350594;35213.82393088018;29271.85364073166;30454;30673.846630767595;31053.378932421678;31183.532247016767;21490.812181221216;22662.09694341452;22749.658755118355;22752;22828.74441905711 09:55:53 INFO - PID 490 | |2;jquery.html;560.8457674139611;566.2610293566894;569.5699746691248;579.953603711703;587.5710731166248;21141.26005589805;21558.89220553899;21906.45233869154;21936.78063219369;21967.890160549196;23777.524449511;25181.874090629568;25307.240782776502;25355;25488.49023019543;6403.999999999988;6502.089707440962;6538.934610653881;6549.639769812658;6571.605703657796;6223.7241365520185;6332.936670633281;6399.456046236076;6408.263049749268;6419.614823110628;4020.9798951005205;4487.708298960573;6369.4585960193435;6446.419822215999;6456.838579035515;6407.9359206408035;6434;6435.646039467827;6441.194850643669;6468.867948109062;6013.248343957005;6019.699015049274;6026.939730602681;6028.788992385245;6034.728437220292;26825.865870670717;28034.719652803415;28507.57238641422;28569.857150714113;28609.14172574826;1947.1432569669441;1966.803319668036;1985.811347921945;1986.0566231040284;1996.8402527797741;18074.90962545192;18103.366382176562;18339.63320733591;18367.448976530726;18380.172892219747;2310.514791893704;2349.8237632177656;2403.9639405408757;2412.2763171048614;2412.300432874464;126466.36766816198;129026;129043.35478322642;129700;130210;13842.515511957034;14419.711605767827;14741;14796;14917.925410372878;23761.881190593936;23787;23788.643170352458;23889.28332150038;23945.880270598536;9747.56135973883;9911.553980070914;9920.801583968425;9937.503124843728;9951;8948.284137269004;9003.279737620975;9090.227405655965;9090.409123406956;9209.861852072225;8613.61238744258;8673.609687564074;8899.243564297107;8964.417312874642;9100.226480749077;2673.17131689177;2678.1563807400607;2709.5664693648923;2736.1107640016676;2740.5204089284293;956.53129966316;974.1622204903778;976.1263669016332;989.9455529945922;999.820032394176;18869.62260754777;19094;19238;19401.126949287314;19622.901885490483;973.6689525561202;1017.7201269650906;1018.0047107668904;1026.9538020200387;1038.133158812385;12499.687507812196;13406.195628262336;13438.731225375437;13463.730725385632;13493.595192144252;497232;506702;507801;512695;521012;108169;108606;108648.4567577157;109040.45479772708;109741.45129274302;1227.895628871556;1244.6017274472083;1254.705144291109;1272.923624582528;1283.2172374851334;18914.905425472785;20007.499812504804;20067.498312542302;20490.795092048887;20663.070161842454;49947.25079123889;50237;51763.74118129536;52019.47980520147;52859.735701321246;61573.69213153906;64361.67819160874;65666;65876.34123658702;65934.67032664806;12536;12615.747685046432;12675.619731408073;12697.746045079231;12851.871481285067;14574.781378279122;14685.97198196116;15225.847741522886;15334.846651533342;17846.821531784517;13551.457941682616;14373.928130359282;14720.273332773799;14930.328135234158;14976.400943962119;12428.937855310665;13534.526291579747;13658.931705341409;13811.79282310746;13986.720265594835;15763.684726305639;15891.682166356839;15926.761098583298;15935.282912269207;16042.358305667643;12412.81380779271;12436;12472.064595155582;12491.562795302121;12494.875051249372;14784.260786960824;15146.318415671542;15165.317560710015;15469.303881325592;15517.76723349128 09:55:53 INFO - PID 490 | |3;mootools.html;1339.8593147719491;1386.8890488760894;1401.1733077484282;1407.6551244944988;1408.4577437686494;13279.601611951633;13804.861951380482;13818.723625527497;13832.861671383283;14124.223167725771;14130.364133613986;14389.1366518009;14437.5668729938;14452;14455.494057707981;2267.2631394796676;2324.31432727345;2325.2326732178426;2325.965110523335;2327.3483424641126;2161.827053835689;2251.7748225177515;2253.2001139595454;2256.3005468304877;2260.728712554496;2208;2230.5761905237955;2244.528648983707;2320.3387034695115;2361.161787565415;2297.7012988311494;2312.2022902098747;2320.872352020638;2325.802306803932;2335.848169868953;2228.9331320060423;2262.909483620653;2264.354658922199;2279.783420575043;2280.9885950570306;13382.799258011137;13723.176609403368;13723.382447789874;13728.725425491533;13732.244726540037;7020.648967551602;7266.164391095039;7267.63661816907;7285.125784905846;7293.671784769698;4317.870463886088;4479.574440428154;4564.908701825945;4580.748058856761;4607.032523170138;1625.8861879668427;1639.5737108351796;1641.2942434753052;1665.39213187187;1706.7610534525177;22347.66478502824;22460;22518.09927602894;22531;22649.773502264932;5856.180134781134;5983.461488466059;5996.490298324691;6074.75700971965;6164.445199931938;15289.541313760383;15301.540953771182;15310.311036003406;15346.23268836576;15363.308651110727;7155.570665760071;7254.746083887038;7262.382697470668;7267.89098163528;7279.199288078307;6706.396424321834;6788.049673045777;6804.591724496546;6831.351021652935;6960.965195174093;4384.605385515319;4456;4509.413776209072;4555.931661025087;4613.146567884952;1249.6938250128594;1251.1054595963928;1254.3101294288106;1273.3505911984769;1273.6815796050987;918.3800934369274;925.6019911438146;937.095702646949;955.2978560757838;964.6286179820679;7411.555306681508;7560.621968901533;7588;7625.733099341496;7632.427567932427;711.1004579207307;727.4362369163835;744.1591002167517;747.9289467500579;756.1606616655617;4618.861434156981;5119.1553393690365;5204.76578553966;5213.6089793265655;5581.6930068845795;17875.553111172325;18380.632387352445;18682.81317186838;18686.71969920452;18688.06559672011;18291.63416731658;18363.816361836478;18586.25654973813;18610.44168674942;18651.347202847835;10400.47997600117;10652.467376631137;11016.394098324668;11167.720806980053;11190.832137517944;8057.879131812911;8117.269445749911;8297.751067467985;8426.957865210634;8456.2812160967;14512.782308265596;15300.234988250766;15457.690846182788;15536.92231538835;15563.610909727347;15020.17389043613;15322.07909806882;15480.767788483407;15616.609584760472;15697.136657483492;11328.376939268419;11491.712707182052;11592.884071159518;11682.182247242952;11854.348010859485;12995.090343675853;13095.541656041993;13105.541306054241;13129.474821007052;13172.670683232996;10407.895921040692;10766.784664306826;10807.081398080936;10946.233763636468;11002.614908478165;10198.490075496344;10385.948070259601;10768.40773757451;10980.560777568808;10999.560017599206;9559.522023898917;9594.856077158709;9624.711258662252;9691.660791872251;9727.07592778685;6891.27641597625;6989.161300643956;7263.854722905407;7344;7362.22696616869;7088;7196.928030719626;7258.709651614087;7329.450291228286;7372.225916278713 09:55:53 INFO - PID 490 | |4;prototype.html;476.76161919040504;498.92979558846275;516.1200153737877;516.8475299786562;522.2557855056543;6165.260168779741;6264.6867656617105;6279.434850863421;6305;6324.399182077701;5914.526837852962;6150.66171360575;6188.504919606432;6195.659238741868;6201.3178550359535;4973.5772459341;4975.3532040834825;4987.850364489072;5007.974960125194;5010.323606313137;4976.726280054596;4982.9252561211615;4985.326980857574;5000.349954505909;5033.848984530452;4981.302617633534;4990.65065445419;4994.750262486861;5009.649324547283;5030.673006254582;4779.784909679072;4967.019788127131;4992;4995.350604421438;5010.2735103409805;4474.798634061475;4477.507474177838;4493.662975276868;4500.684952053358;4513.1425029244665;6062;6063.242094738158;6069.544784141163;6079.148919151322;6102.6948652567635;5672.744726487277;5698.259226300595;5699.2590963174935;5704.743286552073;5721.8569535761935;6525.771597994048;6560.573562718408;6561.80314590563;6598.670066496704;6624.701888414985;4867.221244600847;4877.975610121926;4906.215005599087;4906.852794416173;4918.385201849769;6959.051465589643;6968.407685346751;6990.405815505637;7019.82450438738;7034.085568876065;5011.899762004739;5034.219695947134;5043.672161309503;5043.747812609355;5060.51925067118;5075.949240507622;5101.362329708786;5135.409427915837;5135.61338438627;5139.691618502902;5692.31692196939;5711;5716.4565567296595;5717.256756621696;5726.198332233491;6561.540692151503;6626.768063117865;6634.0712300278;6640.667966601651;6659.3673601008795;1728.0532260313719;1754.438579654524;1767.6818172729031;1771.0613374911318;1777.6178121703895;1209.4678341529698;1216.5802798034663;1227.7605866856056;1243.5274595653593;1248.2073883084126;5605.271314729059;5858.121281807677;5861.267341582302;5875.794347197828;5897.469227769521;6607.438367738796;6658.966705166443;6669.899951500732;6698.363655452724;6731.697073631601;5820.563457740686;5821.359650438449;5836.970815145897;5855.912161317584;5876.147958546072;3566.268914872445;3566.4472006838982;3595.2270261893295;3598.676119149237;3616.5840928293583;6543.44380727634;6545.705443255065;6577.440917522064;6583.769568065095;6603;6820;6853.828654283583;6864.897026544606;6875.724971001104;6888.655567221619;6484.610923344614;6497.902531462032;6526.543141980111;6530.869382612321;6581.572197807127;6620.503462240447;6646.667666616747;6702.229243637044;6706.384510041185;6708.170117515381;6561.179852518435;6634.402903738686;6651.16860392451;6666.666666666551;6693.26374098839;6475.3200913903365;6496.837579060561;6499.967500162469;6530.67346632676;6588.439982601532;5165.276861239355;5277.4194838566955;5412.945870541244;5444.26502422168;5465;6711.295313992156;6813.318668133147;6819.419804602623;6821.556598821061;6841.418479429304;6565.638889861103;6571;6586.341365863375;6587.143671322698;6602.60384376939;6482.286948435574;6507.804765857032;6519.119918810899;6547.770828020996;6558.7538367709985;6486.837829054311;6525.738970441129;6531.412172904462;6565.638889861103;6570.408663220333;6592.934070659232;6606.570572912745;6609;6645.202575690754;6667.299933507106;6412.531175497374;6414.871702565829;6425.06836508713;6444.516661250331;6450.580712253689 09:55:53 INFO - PID 490 | |5;yui.html;839.244679788191;859.6905114158901;870.2994089757744;874.8775171475994;878.4729162502496;17785.911070444647;18493.445196644105;18512.72230916534;18534.165962531686;18589.163487643073;15629;15634.21828908553;15735.60660983476;16462.588435289123;18402.81597184028;1030.7886883188928;1060.2790102730141;1063.803196408663;1064.9893501064967;1066.802641511319;1063.654312348486;1066.983995240072;1067.226260960805;1067.503610820968;1069.7111779819445;1120.6245907620957;1122.7473818390838;1123.955041798327;1125.0549538387752;1130.372643183033;999.7650552120209;1023;1094.9069329106956;1116.865976082867;1118.3904771899333;790.9604519774045;791.4855344026371;791.7466410748563;791.8693415586421;793.1632128104847;18603.62792744151;18683.71974420385;18781.624367512573;18792.62414751711;18802.811971880245;19352.516187095294;19738.309159179502;20179.89910050455;20267.189312427487;20306.28927987528;15590.844091559165;15672.686546269124;15731.134787586678;15731.685366292724;15814.446494372642;3504.4217704078796;3521.8415171317097;3552.467129930505;3560.946585801215;3684.078980254936;94528.16415507477;96154;96673;99434;101323;15614.29735661898;15751.763723544156;15942;15950.122743249232;16040.598985025234;26007;27685;27690.169294921183;27800.304992375353;27807.721922780514;8238;8383.119772423808;8388.161183881684;8485.236328730443;8511.489310641258;4021.6983726220064;4110.691698122653;4113.300738874398;4119.958800411958;4125.5874412558505;4692.577668009895;4733.148033354029;4784.569388755029;4789.784459699322;4843.685160464559;920.4661296448044;921.9400738951947;922.423485321674;927.7958849053198;934.0379409208526;689.9551529150589;707.0702026834696;708.19619731605;712.8538649576824;733.4059411876398;11375.488103035383;11740.295582265091;12776.872231277754;13177.538786142439;13824.447022119002;692.2212510925209;707.2891743797451;709.5352544083634;723.9276072392719;729.3399473476512;5222.843314700565;5400.081986062379;5442.401335853053;5485.561155107582;5588.552915766811;93435.53282233681;99913;100204;103635;103733;62919.99999999908;82681;83531;85912.57043714741;87301.56349218213;63256;72959.27040729631;74898;75496;76323.23676763273;11055.944720276348;11992;12034.819477708017;12264.87735122673;12371.566995155126;31962.52056219112;33087.172820679676;33526;33813;35073.64926350806;60243;60956.39043609507;63025.68487157535;63752.3624763765;68099;16699.24853381625;16719.414820481226;16787.32850685959;16898.831011689726;17041.233144508777;19860.60278794387;20197.394078177676;20277.391678249085;20281.08735106953;20365.592688145858;16559.66880662356;16670.916645416695;16811.41160059392;16895.817292789387;17319.30722771075;18151.183196756443;18383.356582519547;18506.352277670216;18753.90623046876;18849.90575047116;16900.408485703432;17815.10924453798;18308.450746477625;18311.267549297878;18425.81574184241;12028.639140825439;12304.384780760747;12426.192297500633;12585.370731463574;12618.936905315415;13140.145890517086;13280.468781248643;13442.865571344553;13782.7595516404;13895.791563126359 09:55:53 INFO - PID 490 | __end_tp_report 09:55:53 INFO - PID 490 | __start_cc_report 09:55:53 INFO - PID 490 | _x_x_mozilla_cycle_collect,358 09:55:53 INFO - PID 490 | __end_cc_report 09:55:53 INFO - PID 490 | __startTimestamp1498582553770__endTimestamp 09:55:53 INFO - PID 490 | 09:55:53 INFO - PID 490 | ------- Summary: start ------- 09:55:53 INFO - PID 490 | Number of tests: 6 09:55:53 INFO - PID 490 | 09:55:53 INFO - PID 490 | [#0] dojo.html Cycles:165 Average:6084.48 Median:6325.49 stddev:724.49 (11.5%) stddev-sans-first:686.70 09:55:53 INFO - PID 490 | Values: 3057.7 3097.9 3103.8 3114.9 3142.4 5915.6 5981.6 6003.5 6008.3 6055.0 6046.4 6109.5 6148.1 6153.3 6161.2 5657.9 5661.0 5697.0 5704.1 5766.5 5670.0 5750.3 5772.6 5774.7 5781.4 5510.8 5611.7 5640.4 5646.3 5654.1 5427.4 5494.6 5582.0 5613.5 5637.5 5603.6 5617.2 5619.2 5627.5 5667.2 6087.5 6125.1 6152.2 6152.7 6161.5 6604.5 6608.3 6625.7 6638.9 6652.7 6424.6 6500.0 6532.9 6576.9 6708.4 6141.9 6172.7 6174.7 6218.6 6253.0 6843.0 6898.5 6902.8 6910.3 6921.3 6358.2 6435.7 6439.9 6459.9 6474.6 6486.2 6589.0 6605.3 6641.1 6664.8 6588.0 6626.0 6628.2 6658.4 6664.9 6409.5 6643.9 6651.5 6665.3 6670.9 5177.2 5269.1 5284.2 5313.2 5325.8 4542.8 4561.5 4579.7 4602.8 4618.0 5751.8 5805.4 5807.6 5820.1 5843.6 6679.5 6689.3 6697.7 6712.7 6727.8 5713.0 5742.7 5815.7 5836.7 5852.1 5771.3 5796.3 5827.5 5896.1 5906.2 6428.0 6428.3 6481.4 6497.4 6509.9 6652.8 6677.4 6681.8 6685.1 6698.7 6448.8 6449.0 6466.9 6471.0 6479.4 6285.5 6402.0 6410.0 6412.4 6529.0 6600.5 6606.3 6655.6 6663.2 6682.6 6442.9 6458.9 6466.6 6471.3 6481.9 6410.4 6414.1 6420.8 6480.3 6489.1 6133.9 6246.7 6310.2 6315.3 6355.5 6494.1 6510.3 6511.2 6527.5 6537.8 6240.4 6321.8 6325.5 6330.9 6334.1 09:55:53 INFO - PID 490 | 09:55:53 INFO - PID 490 | [#1] ext.html Cycles:180 Average:37183.63 Median:32149.52 stddev:53991.56 (167.9%) stddev-sans-first:54073.81 09:55:53 INFO - PID 490 | Values: 776.3 817.5 845.7 850.3 1154.8 29787.0 31080.1 40428.0 41257.4 41309.0 40953.4 41413.4 41426.6 41448.0 41523.0 7506.4 7701.0 7718.7 7724.5 7731.0 7439.0 7592.8 7710.8 7721.2 7737.2 7647.0 7654.7 7662.5 7672.7 7677.3 7577.3 7607.4 7650.2 7655.0 7685.8 7558.7 7574.3 7602.5 7616.7 7631.5 37449.8 37955.8 37986.6 38078.7 38393.4 3549.9 3582.1 3586.2 3594.1 3613.4 29698.0 29850.7 29895.6 29908.0 29959.1 3672.6 3741.6 3742.1 3779.3 3782.8 193954.0 194330.0 194550.0 194660.0 195740.0 46800.3 46855.0 46922.0 47395.0 47520.3 49251.3 49339.8 49498.5 49523.8 49605.3 15446.5 15470.8 15564.1 15597.1 15605.3 12846.0 12884.9 12933.0 12978.7 13002.2 13776.4 13803.9 13861.0 13891.5 13989.8 5744.3 5747.8 5749.2 5777.7 5804.4 1001.5 1001.8 1003.8 1024.4 1030.2 22292.4 22414.8 22953.1 23013.5 23263.2 1073.3 1094.8 1101.3 1108.0 1109.9 11933.0 11946.9 11982.7 12006.3 12243.9 223460.0 223582.0 225387.0 225411.0 226469.0 49490.3 49633.0 49697.0 49762.5 49778.3 1392.9 1461.9 1467.6 1468.5 1484.8 21199.9 21206.2 21564.6 22300.7 22383.6 35534.0 35601.8 47962.0 49047.3 49475.3 203214.0 203483.0 203806.0 204850.0 205314.0 29563.3 30035.0 30056.1 32090.0 32226.5 40436.0 42907.4 42912.8 43195.6 43524.0 30827.0 31993.5 32028.5 32072.2 32177.8 30904.5 31619.7 31752.5 31893.2 32121.2 33978.2 34669.8 34819.7 35062.6 35213.8 29271.9 30454.0 30673.8 31053.4 31183.5 21490.8 22662.1 22749.7 22752.0 22828.7 09:55:53 INFO - PID 490 | 09:55:53 INFO - PID 490 | [#2] jquery.html Cycles:180 Average:33784.60 Median:13055.85 stddev:85103.55 (651.8%) stddev-sans-first:85305.73 09:55:53 INFO - PID 490 | Values: 560.8 566.3 569.6 580.0 587.6 21141.3 21558.9 21906.5 21936.8 21967.9 23777.5 25181.9 25307.2 25355.0 25488.5 6404.0 6502.1 6538.9 6549.6 6571.6 6223.7 6332.9 6399.5 6408.3 6419.6 4021.0 4487.7 6369.5 6446.4 6456.8 6407.9 6434.0 6435.6 6441.2 6468.9 6013.2 6019.7 6026.9 6028.8 6034.7 26825.9 28034.7 28507.6 28569.9 28609.1 1947.1 1966.8 1985.8 1986.1 1996.8 18074.9 18103.4 18339.6 18367.4 18380.2 2310.5 2349.8 2404.0 2412.3 2412.3 126466.4 129026.0 129043.4 129700.0 130210.0 13842.5 14419.7 14741.0 14796.0 14917.9 23761.9 23787.0 23788.6 23889.3 23945.9 9747.6 9911.6 9920.8 9937.5 9951.0 8948.3 9003.3 9090.2 9090.4 9209.9 8613.6 8673.6 8899.2 8964.4 9100.2 2673.2 2678.2 2709.6 2736.1 2740.5 956.5 974.2 976.1 989.9 999.8 18869.6 19094.0 19238.0 19401.1 19622.9 973.7 1017.7 1018.0 1027.0 1038.1 12499.7 13406.2 13438.7 13463.7 13493.6 497232.0 506702.0 507801.0 512695.0 521012.0 108169.0 108606.0 108648.5 109040.5 109741.5 1227.9 1244.6 1254.7 1272.9 1283.2 18914.9 20007.5 20067.5 20490.8 20663.1 49947.3 50237.0 51763.7 52019.5 52859.7 61573.7 64361.7 65666.0 65876.3 65934.7 12536.0 12615.7 12675.6 12697.7 12851.9 14574.8 14686.0 15225.8 15334.8 17846.8 13551.5 14373.9 14720.3 14930.3 14976.4 12428.9 13534.5 13658.9 13811.8 13986.7 15763.7 15891.7 15926.8 15935.3 16042.4 12412.8 12436.0 12472.1 12491.6 12494.9 14784.3 15146.3 15165.3 15469.3 15517.8 09:55:53 INFO - PID 490 | 09:55:53 INFO - PID 490 | [#3] mootools.html Cycles:180 Average:8418.52 Median:12393.65 stddev:5773.08 (46.6%) stddev-sans-first:5764.78 09:55:53 INFO - PID 490 | Values: 1339.9 1386.9 1401.2 1407.7 1408.5 13279.6 13804.9 13818.7 13832.9 14124.2 14130.4 14389.1 14437.6 14452.0 14455.5 2267.3 2324.3 2325.2 2326.0 2327.3 2161.8 2251.8 2253.2 2256.3 2260.7 2208.0 2230.6 2244.5 2320.3 2361.2 2297.7 2312.2 2320.9 2325.8 2335.8 2228.9 2262.9 2264.4 2279.8 2281.0 13382.8 13723.2 13723.4 13728.7 13732.2 7020.6 7266.2 7267.6 7285.1 7293.7 4317.9 4479.6 4564.9 4580.7 4607.0 1625.9 1639.6 1641.3 1665.4 1706.8 22347.7 22460.0 22518.1 22531.0 22649.8 5856.2 5983.5 5996.5 6074.8 6164.4 15289.5 15301.5 15310.3 15346.2 15363.3 7155.6 7254.7 7262.4 7267.9 7279.2 6706.4 6788.0 6804.6 6831.4 6961.0 4384.6 4456.0 4509.4 4555.9 4613.1 1249.7 1251.1 1254.3 1273.4 1273.7 918.4 925.6 937.1 955.3 964.6 7411.6 7560.6 7588.0 7625.7 7632.4 711.1 727.4 744.2 747.9 756.2 4618.9 5119.2 5204.8 5213.6 5581.7 17875.6 18380.6 18682.8 18686.7 18688.1 18291.6 18363.8 18586.3 18610.4 18651.3 10400.5 10652.5 11016.4 11167.7 11190.8 8057.9 8117.3 8297.8 8427.0 8456.3 14512.8 15300.2 15457.7 15536.9 15563.6 15020.2 15322.1 15480.8 15616.6 15697.1 11328.4 11491.7 11592.9 11682.2 11854.3 12995.1 13095.5 13105.5 13129.5 13172.7 10407.9 10766.8 10807.1 10946.2 11002.6 10198.5 10385.9 10768.4 10980.6 10999.6 9559.5 9594.9 9624.7 9691.7 9727.1 6891.3 6989.2 7263.9 7344.0 7362.2 7088.0 7196.9 7258.7 7329.5 7372.2 09:55:53 INFO - PID 490 | 09:55:53 INFO - PID 490 | [#4] prototype.html Cycles:180 Average:5544.99 Median:6126.68 stddev:1551.53 (25.3%) stddev-sans-first:1508.53 09:55:53 INFO - PID 490 | Values: 476.8 498.9 516.1 516.8 522.3 6165.3 6264.7 6279.4 6305.0 6324.4 5914.5 6150.7 6188.5 6195.7 6201.3 4973.6 4975.4 4987.9 5008.0 5010.3 4976.7 4982.9 4985.3 5000.3 5033.8 4981.3 4990.7 4994.8 5009.6 5030.7 4779.8 4967.0 4992.0 4995.4 5010.3 4474.8 4477.5 4493.7 4500.7 4513.1 6062.0 6063.2 6069.5 6079.1 6102.7 5672.7 5698.3 5699.3 5704.7 5721.9 6525.8 6560.6 6561.8 6598.7 6624.7 4867.2 4878.0 4906.2 4906.9 4918.4 6959.1 6968.4 6990.4 7019.8 7034.1 5011.9 5034.2 5043.7 5043.7 5060.5 5075.9 5101.4 5135.4 5135.6 5139.7 5692.3 5711.0 5716.5 5717.3 5726.2 6561.5 6626.8 6634.1 6640.7 6659.4 1728.1 1754.4 1767.7 1771.1 1777.6 1209.5 1216.6 1227.8 1243.5 1248.2 5605.3 5858.1 5861.3 5875.8 5897.5 6607.4 6659.0 6669.9 6698.4 6731.7 5820.6 5821.4 5837.0 5855.9 5876.1 3566.3 3566.4 3595.2 3598.7 3616.6 6543.4 6545.7 6577.4 6583.8 6603.0 6820.0 6853.8 6864.9 6875.7 6888.7 6484.6 6497.9 6526.5 6530.9 6581.6 6620.5 6646.7 6702.2 6706.4 6708.2 6561.2 6634.4 6651.2 6666.7 6693.3 6475.3 6496.8 6500.0 6530.7 6588.4 5165.3 5277.4 5412.9 5444.3 5465.0 6711.3 6813.3 6819.4 6821.6 6841.4 6565.6 6571.0 6586.3 6587.1 6602.6 6482.3 6507.8 6519.1 6547.8 6558.8 6486.8 6525.7 6531.4 6565.6 6570.4 6592.9 6606.6 6609.0 6645.2 6667.3 6412.5 6414.9 6425.1 6444.5 6450.6 09:55:53 INFO - PID 490 | 09:55:53 INFO - PID 490 | [#5] yui.html Cycles:180 Average:20982.24 Median:20020.25 stddev:26823.01 (134.0%) stddev-sans-first:26855.61 09:55:53 INFO - PID 490 | Values: 839.2 859.7 870.3 874.9 878.5 17785.9 18493.4 18512.7 18534.2 18589.2 15629.0 15634.2 15735.6 16462.6 18402.8 1030.8 1060.3 1063.8 1065.0 1066.8 1063.7 1067.0 1067.2 1067.5 1069.7 1120.6 1122.7 1124.0 1125.1 1130.4 999.8 1023.0 1094.9 1116.9 1118.4 791.0 791.5 791.7 791.9 793.2 18603.6 18683.7 18781.6 18792.6 18802.8 19352.5 19738.3 20179.9 20267.2 20306.3 15590.8 15672.7 15731.1 15731.7 15814.4 3504.4 3521.8 3552.5 3560.9 3684.1 94528.2 96154.0 96673.0 99434.0 101323.0 15614.3 15751.8 15942.0 15950.1 16040.6 26007.0 27685.0 27690.2 27800.3 27807.7 8238.0 8383.1 8388.2 8485.2 8511.5 4021.7 4110.7 4113.3 4120.0 4125.6 4692.6 4733.1 4784.6 4789.8 4843.7 920.5 921.9 922.4 927.8 934.0 690.0 707.1 708.2 712.9 733.4 11375.5 11740.3 12776.9 13177.5 13824.4 692.2 707.3 709.5 723.9 729.3 5222.8 5400.1 5442.4 5485.6 5588.6 93435.5 99913.0 100204.0 103635.0 103733.0 62920.0 82681.0 83531.0 85912.6 87301.6 63256.0 72959.3 74898.0 75496.0 76323.2 11055.9 11992.0 12034.8 12264.9 12371.6 31962.5 33087.2 33526.0 33813.0 35073.6 60243.0 60956.4 63025.7 63752.4 68099.0 16699.2 16719.4 16787.3 16898.8 17041.2 19860.6 20197.4 20277.4 20281.1 20365.6 16559.7 16670.9 16811.4 16895.8 17319.3 18151.2 18383.4 18506.4 18753.9 18849.9 16900.4 17815.1 18308.5 18311.3 18425.8 12028.6 12304.4 12426.2 12585.4 12618.9 13140.1 13280.5 13442.9 13782.8 13895.8 09:55:53 INFO - PID 490 | -------- Summary: end -------- 09:55:53 INFO - PID 490 | 09:55:54 INFO - TEST-INFO | 490: exit 0 09:55:54 INFO - TEST-OK | dromaeo_css | took 1116526ms 09:55:54 INFO - TEST-START | kraken 09:55:54 INFO - operating with platform_type : linux_ 09:55:54 INFO - Initialising browser for kraken test... 09:55:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44462/getInfo.html -profile /tmp/tmpJK3TaS/profile 09:55:54 INFO - TEST-INFO | started process 915 (/builds/slave/test/build/application/firefox/firefox http://localhost:44462/getInfo.html) 09:56:00 INFO - TEST-INFO | 915: exit 0 09:56:00 INFO - Browser initialized. 09:56:00 INFO - Running cycle 1/1 for kraken test... 09:56:00 INFO - TEST-INFO | started process 1207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJK3TaS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:11 INFO - PID 1207 | RSS: Main: 171614208 09:56:11 INFO - PID 1207 | 09:56:14 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44462/tests/kraken/driver.html?testName=audio-beat-detection) 09:56:15 INFO - PID 1207 | RSS: Main: 176574464 09:56:15 INFO - PID 1207 | 09:56:18 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44462/tests/kraken/driver.html?testName=audio-dft) 09:56:18 INFO - PID 1207 | RSS: Main: 177192960 09:56:18 INFO - PID 1207 | 09:56:21 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44462/tests/kraken/driver.html?testName=audio-fft) 09:56:22 INFO - PID 1207 | RSS: Main: 171864064 09:56:22 INFO - PID 1207 | 09:56:24 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44462/tests/kraken/driver.html?testName=audio-oscillator) 09:56:24 INFO - PID 1207 | RSS: Main: 173092864 09:56:24 INFO - PID 1207 | 09:56:27 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:56:27 INFO - PID 1207 | RSS: Main: 173420544 09:56:27 INFO - PID 1207 | 09:56:30 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44462/tests/kraken/driver.html?testName=imaging-darkroom) 09:56:31 INFO - PID 1207 | RSS: Main: 175984640 09:56:31 INFO - PID 1207 | 09:56:34 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44462/tests/kraken/driver.html?testName=imaging-desaturate) 09:56:35 INFO - PID 1207 | RSS: Main: 177774592 09:56:35 INFO - PID 1207 | 09:56:38 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44462/tests/kraken/driver.html?testName=json-parse-financial) 09:56:38 INFO - PID 1207 | RSS: Main: 177610752 09:56:38 INFO - PID 1207 | 09:56:40 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:56:41 INFO - PID 1207 | RSS: Main: 176611328 09:56:41 INFO - PID 1207 | 09:56:42 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44462/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:56:43 INFO - PID 1207 | RSS: Main: 177160192 09:56:43 INFO - PID 1207 | 09:56:45 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:56:46 INFO - PID 1207 | RSS: Main: 176971776 09:56:46 INFO - PID 1207 | 09:56:48 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:56:49 INFO - PID 1207 | RSS: Main: 176848896 09:56:49 INFO - PID 1207 | 09:56:52 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:56:53 INFO - PID 1207 | RSS: Main: 176975872 09:56:53 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | Cycle 1(1): loaded http://localhost:44462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44462/tests/kraken/driver.html?testName=ai-astar) 09:56:55 INFO - PID 1207 | RSS: Main: 177934336 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | __start_tp_report 09:56:55 INFO - PID 1207 | _x_x_mozilla_page_load 09:56:55 INFO - PID 1207 | _x_x_mozilla_page_load_details 09:56:55 INFO - PID 1207 | |i|pagename|runs| 09:56:55 INFO - PID 1207 | |0;ai-astar;101;108;109;107;108;108;109;108;111;111 09:56:55 INFO - PID 1207 | |1;audio-beat-detection;146;120;147;182;124;153;152;125;169;120 09:56:55 INFO - PID 1207 | |2;audio-dft;164;160;161;160;161;171;166;162;166;163 09:56:55 INFO - PID 1207 | |3;audio-fft;75;75;75;153;75;76;75;74;99;75 09:56:55 INFO - PID 1207 | |4;audio-oscillator;80;82;136;81;83;82;134;81;82;130 09:56:55 INFO - PID 1207 | |5;imaging-gaussian-blur;114;114;113;114;114;114;113;114;113;113 09:56:55 INFO - PID 1207 | |6;imaging-darkroom;150;149;150;149;150;149;151;149;149;150 09:56:55 INFO - PID 1207 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;95;94 09:56:55 INFO - PID 1207 | |8;json-parse-financial;59;57;57;56;61;57;54;56;55;59 09:56:55 INFO - PID 1207 | |9;json-stringify-tinderbox;54;53;54;53;53;54;54;53;53;53 09:56:55 INFO - PID 1207 | |10;stanford-crypto-aes;86;78;78;81;81;80;79;77;77;80 09:56:55 INFO - PID 1207 | |11;stanford-crypto-ccm;126;129;126;126;127;129;127;126;129;167 09:56:55 INFO - PID 1207 | |12;stanford-crypto-pbkdf2;192;187;188;190;186;190;196;182;194;188 09:56:55 INFO - PID 1207 | |13;stanford-crypto-sha256-iterative;70;68;67;68;72;68;71;67;68;67 09:56:55 INFO - PID 1207 | __end_tp_report 09:56:55 INFO - PID 1207 | __start_cc_report 09:56:55 INFO - PID 1207 | _x_x_mozilla_cycle_collect,962 09:56:55 INFO - PID 1207 | __end_cc_report 09:56:55 INFO - PID 1207 | __startTimestamp1498582615343__endTimestamp 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | ------- Summary: start ------- 09:56:55 INFO - PID 1207 | Number of tests: 14 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.50 stddev:2.79 (2.6%) stddev-sans-first:1.39 09:56:55 INFO - PID 1207 | Values: 101.0 108.0 109.0 107.0 108.0 108.0 109.0 108.0 111.0 111.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:149.50 stddev:21.45 (14.3%) stddev-sans-first:22.73 09:56:55 INFO - PID 1207 | Values: 146.0 120.0 147.0 182.0 124.0 153.0 152.0 125.0 169.0 120.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:3.47 (2.1%) stddev-sans-first:3.67 09:56:55 INFO - PID 1207 | Values: 164.0 160.0 161.0 160.0 161.0 171.0 166.0 162.0 166.0 163.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#3] audio-fft Cycles:10 Average:85.20 Median:75.00 stddev:24.99 (33.3%) stddev-sans-first:26.23 09:56:55 INFO - PID 1207 | Values: 75.0 75.0 75.0 153.0 75.0 76.0 75.0 74.0 99.0 75.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:81.50 stddev:25.06 (30.7%) stddev-sans-first:25.80 09:56:55 INFO - PID 1207 | Values: 80.0 82.0 136.0 81.0 83.0 82.0 134.0 81.0 82.0 130.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:56:55 INFO - PID 1207 | Values: 114.0 114.0 113.0 114.0 114.0 114.0 113.0 114.0 113.0 113.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:56:55 INFO - PID 1207 | Values: 150.0 149.0 150.0 149.0 150.0 149.0 151.0 149.0 149.0 150.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:56:55 INFO - PID 1207 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:2.08 (3.6%) stddev-sans-first:2.09 09:56:55 INFO - PID 1207 | Values: 59.0 57.0 57.0 56.0 61.0 57.0 54.0 56.0 55.0 59.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.50 09:56:55 INFO - PID 1207 | Values: 54.0 53.0 54.0 53.0 53.0 54.0 54.0 53.0 53.0 53.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:2.67 (3.3%) stddev-sans-first:1.58 09:56:55 INFO - PID 1207 | Values: 86.0 78.0 78.0 81.0 81.0 80.0 79.0 77.0 77.0 80.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:128.00 stddev:12.65 (9.9%) stddev-sans-first:13.27 09:56:55 INFO - PID 1207 | Values: 126.0 129.0 126.0 126.0 127.0 129.0 127.0 126.0 129.0 167.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.30 Median:190.00 stddev:4.06 (2.1%) stddev-sans-first:4.18 09:56:55 INFO - PID 1207 | Values: 192.0 187.0 188.0 190.0 186.0 190.0 196.0 182.0 194.0 188.0 09:56:55 INFO - PID 1207 | 09:56:55 INFO - PID 1207 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:1.78 (2.6%) stddev-sans-first:1.81 09:56:55 INFO - PID 1207 | Values: 70.0 68.0 67.0 68.0 72.0 68.0 71.0 67.0 68.0 67.0 09:56:55 INFO - PID 1207 | -------- Summary: end -------- 09:56:55 INFO - PID 1207 | 09:56:56 INFO - TEST-INFO | 1207: exit 0 09:56:56 INFO - TEST-OK | kraken | took 61783ms 09:56:56 INFO - SUITE-END | took 1178s 09:56:56 INFO - Completed test suite (00:19:38) 09:56:56 INFO - javascript benchmark 09:56:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8203.70481376738, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.6636569977286, 3097.8915737949164, 3103.782735208535, 3114.937701245975, 3142.4029434407475, 5915.556333275, 5981.551383646222, 6003.459688628022, 6008.279006519213, 6055.0311950088, 6046.425589568995, 6109.450149486545, 6148.1392605035335, 6153.2923713772925, 6161.229846269216, 5657.915131273035, 5661.0, 5696.971515142419, 5704.058830292996, 5766.538676905838, 5670.0, 5750.281214848144, 5772.595918285721, 5774.711264436783, 5781.364049954502, 5510.8071217507595, 5611.663300202001, 5640.351359593617, 5646.26598542191, 5654.067078931971, 5427.375851777057, 5494.587905907073, 5582.0, 5613.494785469327, 5637.492625663669, 5603.579731520112, 5617.241672374218, 5619.185218143346, 5627.549796016309, 5667.206591077253, 6087.4521293083835, 6125.142480052797, 6152.16945712332, 6152.661603611799, 6161.50707943368, 6604.504662150358, 6608.339166083353, 6625.668716564201, 6638.93361066388, 6652.667366631649, 6424.5502814802985, 6499.967500162469, 6532.869342613169, 6576.901346479759, 6708.396244338033, 6141.907871381933, 6172.6913654318005, 6174.6912654368, 6218.626882387071, 6253.0, 6843.0, 6898.482613803984, 6902.827429314308, 6910.274421185703, 6921.273266307066, 6358.237011558643, 6435.710393032325, 6439.871202575922, 6459.935400646027, 6474.643894585749, 6486.189226346707, 6588.96705516479, 6605.30644282353, 6641.070250164981, 6664.8000559983275, 6588.044733513614, 6625.966870165715, 6628.204615446178, 6658.3674550917585, 6664.86670266592, 6409.519286053564, 6643.900341494785, 6651.467882569383, 6665.300143484864, 6670.899936500957, 5177.171652535576, 5269.077911365495, 5284.154535274338, 5313.229581710708, 5325.786968521215, 4542.84100056503, 4561.498235194126, 4579.74811385377, 4602.792874320664, 4617.976910115495, 5751.827445176651, 5805.36141024487, 5807.622504537191, 5820.068788993741, 5843.649381037151, 6679.539369569286, 6689.297623749533, 6697.6986035628515, 6712.697928593225, 6727.798166055026, 5713.0, 5742.712864356766, 5815.680137592389, 5836.708164591753, 5852.063669812809, 5771.307443106854, 5796.304443466811, 5827.475527202572, 5896.056630939115, 5906.202662640489, 6427.999999999906, 6428.292887782247, 6481.4166724994975, 6497.382748638872, 6509.934900650933, 6652.833679157866, 6677.43241824431, 6681.76613818514, 6685.064091027358, 6698.7320507179165, 6448.838779030374, 6449.0, 6466.902996455151, 6471.0, 6479.449246814073, 6285.465735412541, 6402.03969404593, 6410.038494225903, 6412.39082287182, 6529.0, 6600.504962127764, 6606.339366063356, 6655.600663960178, 6663.200415950117, 6682.63245521501, 6442.871142577029, 6458.935410645833, 6466.579672321284, 6471.288158302677, 6481.935180648133, 6410.358964103552, 6414.134091897721, 6420.807375778734, 6480.287168411565, 6489.091527186292, 6133.916185115316, 6246.718897649707, 6310.242770867525, 6315.336889626707, 6355.459785918249, 6494.090827284279, 6510.251321097945, 6511.21865376139, 6527.477801775752, 6537.803865884031, 6240.375962403723, 6321.841953951004, 6325.4939604832425, 6330.9237429638, 6334.144890439732], "value": 6029.507986451699, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.2741836382979, 817.5299202958298, 845.742048675154, 850.3409857360544, 1154.8498695169626, 29787.0, 31080.06759797204, 40428.0, 41257.38113928294, 41309.0, 40953.38569921454, 41413.37879931796, 41426.58573414265, 41448.0, 41523.0, 7506.437017223717, 7701.0, 7718.652660630285, 7724.536527808322, 7731.0, 7439.0, 7592.810179745496, 7710.845783084335, 7721.189275126115, 7737.226277372246, 7647.0, 7654.655540500691, 7662.463627546074, 7672.731454399097, 7677.347425468842, 7577.318041376275, 7607.391408687292, 7650.158482566913, 7655.043119610049, 7685.807854803618, 7558.659860306299, 7574.31831135195, 7602.467827252094, 7616.657250423744, 7631.503952243086, 37449.81275093607, 37955.810220948995, 37986.62013379886, 38078.66724664623, 38393.42409863854, 3549.8580056797696, 3582.1223800168864, 3586.193106551031, 3594.11944073701, 3613.403788374915, 29698.0, 29850.70149298501, 29895.551566726517, 29908.0, 29959.101226963227, 3672.6143754905615, 3741.625837416264, 3742.0644838790304, 3779.338615742234, 3782.7919464429447, 193954.0, 194329.99999999857, 194550.0, 194660.026699867, 195740.0, 46800.297995529414, 46855.0, 46922.0, 47395.0, 47520.28719569209, 49251.26123108156, 49339.753301233985, 49498.50501495011, 49523.752381238584, 49605.25592116121, 15446.5366039019, 15470.767938480933, 15564.066156030674, 15597.142157181464, 15605.297761600756, 12846.0, 12884.935575322063, 12933.0, 12978.740425191443, 13002.219866808022, 13776.380062897193, 13803.930980345034, 13861.0, 13891.513797017258, 13989.790153147711, 5744.310682718101, 5747.770089196469, 5749.223854779551, 5777.653340799566, 5804.4195580442465, 1001.5442973447064, 1001.8397056471075, 1003.7641154328727, 1024.4263212600817, 1030.1655658916302, 22292.44268893258, 22414.775852241593, 22953.08187672508, 23013.53972920532, 23263.18578849732, 1073.2862646340252, 1094.8066607397975, 1101.2841652925501, 1107.9889201108047, 1109.938953357557, 11933.0, 11946.880531194576, 11982.700432489084, 12006.279623222634, 12243.938780306042, 223460.0, 223582.0, 225387.0, 225411.0, 226469.0, 49490.25764613534, 49633.0, 49697.0, 49762.50237497651, 49778.25332620014, 1392.9036799616715, 1461.883049356049, 1467.625755432358, 1468.4933697874217, 1484.8292446368805, 21199.894000529897, 21206.15175392967, 21564.568708625426, 22300.665490017338, 22383.552328953003, 35534.0, 35601.82199088988, 47962.0, 49047.26429103638, 49475.257871131245, 203214.0, 203483.0, 203806.0, 204850.0, 205314.0, 29563.26091847721, 30035.0, 30056.098317050524, 32090.0, 32226.516602250515, 40436.0, 42907.35638965481, 42912.78543607262, 43195.56804432041, 43524.0, 30827.0, 31993.520097198096, 32028.5195722069, 32072.198195045312, 32177.839110804296, 30904.53643195309, 31619.683803161675, 31752.523712143873, 31893.20266993344, 32121.196970075936, 33978.15054623654, 34669.826650866584, 34819.65180348265, 35062.64937350594, 35213.82393088018, 29271.85364073166, 30454.0, 30673.846630767595, 31053.378932421678, 31183.532247016767, 21490.812181221216, 22662.09694341452, 22749.658755118355, 22752.0, 22828.74441905711], "value": 16757.816014678436, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.8457674139611, 566.2610293566894, 569.5699746691248, 579.953603711703, 587.5710731166248, 21141.26005589805, 21558.89220553899, 21906.45233869154, 21936.78063219369, 21967.890160549196, 23777.524449511, 25181.874090629568, 25307.240782776502, 25355.0, 25488.49023019543, 6403.999999999988, 6502.089707440962, 6538.934610653881, 6549.639769812658, 6571.605703657796, 6223.7241365520185, 6332.936670633281, 6399.456046236076, 6408.263049749268, 6419.614823110628, 4020.9798951005205, 4487.708298960573, 6369.4585960193435, 6446.419822215999, 6456.838579035515, 6407.9359206408035, 6434.0, 6435.646039467827, 6441.194850643669, 6468.867948109062, 6013.248343957005, 6019.699015049274, 6026.939730602681, 6028.788992385245, 6034.728437220292, 26825.865870670717, 28034.719652803415, 28507.57238641422, 28569.857150714113, 28609.14172574826, 1947.1432569669441, 1966.803319668036, 1985.811347921945, 1986.0566231040284, 1996.8402527797741, 18074.90962545192, 18103.366382176562, 18339.63320733591, 18367.448976530726, 18380.172892219747, 2310.514791893704, 2349.8237632177656, 2403.9639405408757, 2412.2763171048614, 2412.300432874464, 126466.36766816198, 129026.0, 129043.35478322642, 129700.0, 130210.0, 13842.515511957034, 14419.711605767827, 14741.0, 14796.0, 14917.925410372878, 23761.881190593936, 23787.0, 23788.643170352458, 23889.28332150038, 23945.880270598536, 9747.56135973883, 9911.553980070914, 9920.801583968425, 9937.503124843728, 9951.0, 8948.284137269004, 9003.279737620975, 9090.227405655965, 9090.409123406956, 9209.861852072225, 8613.61238744258, 8673.609687564074, 8899.243564297107, 8964.417312874642, 9100.226480749077, 2673.17131689177, 2678.1563807400607, 2709.5664693648923, 2736.1107640016676, 2740.5204089284293, 956.53129966316, 974.1622204903778, 976.1263669016332, 989.9455529945922, 999.820032394176, 18869.62260754777, 19094.0, 19238.0, 19401.126949287314, 19622.901885490483, 973.6689525561202, 1017.7201269650906, 1018.0047107668904, 1026.9538020200387, 1038.133158812385, 12499.687507812196, 13406.195628262336, 13438.731225375437, 13463.730725385632, 13493.595192144252, 497232.0, 506702.0, 507801.0, 512695.0, 521012.0, 108169.0, 108606.0, 108648.4567577157, 109040.45479772708, 109741.45129274302, 1227.895628871556, 1244.6017274472083, 1254.705144291109, 1272.923624582528, 1283.2172374851334, 18914.905425472785, 20007.499812504804, 20067.498312542302, 20490.795092048887, 20663.070161842454, 49947.25079123889, 50237.0, 51763.74118129536, 52019.47980520147, 52859.735701321246, 61573.69213153906, 64361.67819160874, 65666.0, 65876.34123658702, 65934.67032664806, 12536.0, 12615.747685046432, 12675.619731408073, 12697.746045079231, 12851.871481285067, 14574.781378279122, 14685.97198196116, 15225.847741522886, 15334.846651533342, 17846.821531784517, 13551.457941682616, 14373.928130359282, 14720.273332773799, 14930.328135234158, 14976.400943962119, 12428.937855310665, 13534.526291579747, 13658.931705341409, 13811.79282310746, 13986.720265594835, 15763.684726305639, 15891.682166356839, 15926.761098583298, 15935.282912269207, 16042.358305667643, 12412.81380779271, 12436.0, 12472.064595155582, 12491.562795302121, 12494.875051249372, 14784.260786960824, 15146.318415671542, 15165.317560710015, 15469.303881325592, 15517.76723349128], "value": 11325.222329473143, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.8593147719491, 1386.8890488760894, 1401.1733077484282, 1407.6551244944988, 1408.4577437686494, 13279.601611951633, 13804.861951380482, 13818.723625527497, 13832.861671383283, 14124.223167725771, 14130.364133613986, 14389.1366518009, 14437.5668729938, 14452.0, 14455.494057707981, 2267.2631394796676, 2324.31432727345, 2325.2326732178426, 2325.965110523335, 2327.3483424641126, 2161.827053835689, 2251.7748225177515, 2253.2001139595454, 2256.3005468304877, 2260.728712554496, 2208.0, 2230.5761905237955, 2244.528648983707, 2320.3387034695115, 2361.161787565415, 2297.7012988311494, 2312.2022902098747, 2320.872352020638, 2325.802306803932, 2335.848169868953, 2228.9331320060423, 2262.909483620653, 2264.354658922199, 2279.783420575043, 2280.9885950570306, 13382.799258011137, 13723.176609403368, 13723.382447789874, 13728.725425491533, 13732.244726540037, 7020.648967551602, 7266.164391095039, 7267.63661816907, 7285.125784905846, 7293.671784769698, 4317.870463886088, 4479.574440428154, 4564.908701825945, 4580.748058856761, 4607.032523170138, 1625.8861879668427, 1639.5737108351796, 1641.2942434753052, 1665.39213187187, 1706.7610534525177, 22347.66478502824, 22460.0, 22518.09927602894, 22531.0, 22649.773502264932, 5856.180134781134, 5983.461488466059, 5996.490298324691, 6074.75700971965, 6164.445199931938, 15289.541313760383, 15301.540953771182, 15310.311036003406, 15346.23268836576, 15363.308651110727, 7155.570665760071, 7254.746083887038, 7262.382697470668, 7267.89098163528, 7279.199288078307, 6706.396424321834, 6788.049673045777, 6804.591724496546, 6831.351021652935, 6960.965195174093, 4384.605385515319, 4456.0, 4509.413776209072, 4555.931661025087, 4613.146567884952, 1249.6938250128594, 1251.1054595963928, 1254.3101294288106, 1273.3505911984769, 1273.6815796050987, 918.3800934369274, 925.6019911438146, 937.095702646949, 955.2978560757838, 964.6286179820679, 7411.555306681508, 7560.621968901533, 7588.0, 7625.733099341496, 7632.427567932427, 711.1004579207307, 727.4362369163835, 744.1591002167517, 747.9289467500579, 756.1606616655617, 4618.861434156981, 5119.1553393690365, 5204.76578553966, 5213.6089793265655, 5581.6930068845795, 17875.553111172325, 18380.632387352445, 18682.81317186838, 18686.71969920452, 18688.06559672011, 18291.63416731658, 18363.816361836478, 18586.25654973813, 18610.44168674942, 18651.347202847835, 10400.47997600117, 10652.467376631137, 11016.394098324668, 11167.720806980053, 11190.832137517944, 8057.879131812911, 8117.269445749911, 8297.751067467985, 8426.957865210634, 8456.2812160967, 14512.782308265596, 15300.234988250766, 15457.690846182788, 15536.92231538835, 15563.610909727347, 15020.17389043613, 15322.07909806882, 15480.767788483407, 15616.609584760472, 15697.136657483492, 11328.376939268419, 11491.712707182052, 11592.884071159518, 11682.182247242952, 11854.348010859485, 12995.090343675853, 13095.541656041993, 13105.541306054241, 13129.474821007052, 13172.670683232996, 10407.895921040692, 10766.784664306826, 10807.081398080936, 10946.233763636468, 11002.614908478165, 10198.490075496344, 10385.948070259601, 10768.40773757451, 10980.560777568808, 10999.560017599206, 9559.522023898917, 9594.856077158709, 9624.711258662252, 9691.660791872251, 9727.07592778685, 6891.27641597625, 6989.161300643956, 7263.854722905407, 7344.0, 7362.22696616869, 7088.0, 7196.928030719626, 7258.709651614087, 7329.450291228286, 7372.225916278713], "value": 6032.079521620118, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.76161919040504, 498.92979558846275, 516.1200153737877, 516.8475299786562, 522.2557855056543, 6165.260168779741, 6264.6867656617105, 6279.434850863421, 6305.0, 6324.399182077701, 5914.526837852962, 6150.66171360575, 6188.504919606432, 6195.659238741868, 6201.3178550359535, 4973.5772459341, 4975.3532040834825, 4987.850364489072, 5007.974960125194, 5010.323606313137, 4976.726280054596, 4982.9252561211615, 4985.326980857574, 5000.349954505909, 5033.848984530452, 4981.302617633534, 4990.65065445419, 4994.750262486861, 5009.649324547283, 5030.673006254582, 4779.784909679072, 4967.019788127131, 4992.0, 4995.350604421438, 5010.2735103409805, 4474.798634061475, 4477.507474177838, 4493.662975276868, 4500.684952053358, 4513.1425029244665, 6062.0, 6063.242094738158, 6069.544784141163, 6079.148919151322, 6102.6948652567635, 5672.744726487277, 5698.259226300595, 5699.2590963174935, 5704.743286552073, 5721.8569535761935, 6525.771597994048, 6560.573562718408, 6561.80314590563, 6598.670066496704, 6624.701888414985, 4867.221244600847, 4877.975610121926, 4906.215005599087, 4906.852794416173, 4918.385201849769, 6959.051465589643, 6968.407685346751, 6990.405815505637, 7019.82450438738, 7034.085568876065, 5011.899762004739, 5034.219695947134, 5043.672161309503, 5043.747812609355, 5060.51925067118, 5075.949240507622, 5101.362329708786, 5135.409427915837, 5135.61338438627, 5139.691618502902, 5692.31692196939, 5711.0, 5716.4565567296595, 5717.256756621696, 5726.198332233491, 6561.540692151503, 6626.768063117865, 6634.0712300278, 6640.667966601651, 6659.3673601008795, 1728.0532260313719, 1754.438579654524, 1767.6818172729031, 1771.0613374911318, 1777.6178121703895, 1209.4678341529698, 1216.5802798034663, 1227.7605866856056, 1243.5274595653593, 1248.2073883084126, 5605.271314729059, 5858.121281807677, 5861.267341582302, 5875.794347197828, 5897.469227769521, 6607.438367738796, 6658.966705166443, 6669.899951500732, 6698.363655452724, 6731.697073631601, 5820.563457740686, 5821.359650438449, 5836.970815145897, 5855.912161317584, 5876.147958546072, 3566.268914872445, 3566.4472006838982, 3595.2270261893295, 3598.676119149237, 3616.5840928293583, 6543.44380727634, 6545.705443255065, 6577.440917522064, 6583.769568065095, 6603.0, 6820.0, 6853.828654283583, 6864.897026544606, 6875.724971001104, 6888.655567221619, 6484.610923344614, 6497.902531462032, 6526.543141980111, 6530.869382612321, 6581.572197807127, 6620.503462240447, 6646.667666616747, 6702.229243637044, 6706.384510041185, 6708.170117515381, 6561.179852518435, 6634.402903738686, 6651.16860392451, 6666.666666666551, 6693.26374098839, 6475.3200913903365, 6496.837579060561, 6499.967500162469, 6530.67346632676, 6588.439982601532, 5165.276861239355, 5277.4194838566955, 5412.945870541244, 5444.26502422168, 5465.0, 6711.295313992156, 6813.318668133147, 6819.419804602623, 6821.556598821061, 6841.418479429304, 6565.638889861103, 6571.0, 6586.341365863375, 6587.143671322698, 6602.60384376939, 6482.286948435574, 6507.804765857032, 6519.119918810899, 6547.770828020996, 6558.7538367709985, 6486.837829054311, 6525.738970441129, 6531.412172904462, 6565.638889861103, 6570.408663220333, 6592.934070659232, 6606.570572912745, 6609.0, 6645.202575690754, 6667.299933507106, 6412.531175497374, 6414.871702565829, 6425.06836508713, 6444.516661250331, 6450.580712253689], "value": 5085.381133980528, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.244679788191, 859.6905114158901, 870.2994089757744, 874.8775171475994, 878.4729162502496, 17785.911070444647, 18493.445196644105, 18512.72230916534, 18534.165962531686, 18589.163487643073, 15629.0, 15634.21828908553, 15735.60660983476, 16462.588435289123, 18402.81597184028, 1030.7886883188928, 1060.2790102730141, 1063.803196408663, 1064.9893501064967, 1066.802641511319, 1063.654312348486, 1066.983995240072, 1067.226260960805, 1067.503610820968, 1069.7111779819445, 1120.6245907620957, 1122.7473818390838, 1123.955041798327, 1125.0549538387752, 1130.372643183033, 999.7650552120209, 1023.0, 1094.9069329106956, 1116.865976082867, 1118.3904771899333, 790.9604519774045, 791.4855344026371, 791.7466410748563, 791.8693415586421, 793.1632128104847, 18603.62792744151, 18683.71974420385, 18781.624367512573, 18792.62414751711, 18802.811971880245, 19352.516187095294, 19738.309159179502, 20179.89910050455, 20267.189312427487, 20306.28927987528, 15590.844091559165, 15672.686546269124, 15731.134787586678, 15731.685366292724, 15814.446494372642, 3504.4217704078796, 3521.8415171317097, 3552.467129930505, 3560.946585801215, 3684.078980254936, 94528.16415507477, 96154.0, 96673.0, 99434.0, 101323.0, 15614.29735661898, 15751.763723544156, 15942.0, 15950.122743249232, 16040.598985025234, 26007.0, 27685.0, 27690.169294921183, 27800.304992375353, 27807.721922780514, 8238.0, 8383.119772423808, 8388.161183881684, 8485.236328730443, 8511.489310641258, 4021.6983726220064, 4110.691698122653, 4113.300738874398, 4119.958800411958, 4125.5874412558505, 4692.577668009895, 4733.148033354029, 4784.569388755029, 4789.784459699322, 4843.685160464559, 920.4661296448044, 921.9400738951947, 922.423485321674, 927.7958849053198, 934.0379409208526, 689.9551529150589, 707.0702026834696, 708.19619731605, 712.8538649576824, 733.4059411876398, 11375.488103035383, 11740.295582265091, 12776.872231277754, 13177.538786142439, 13824.447022119002, 692.2212510925209, 707.2891743797451, 709.5352544083634, 723.9276072392719, 729.3399473476512, 5222.843314700565, 5400.081986062379, 5442.401335853053, 5485.561155107582, 5588.552915766811, 93435.53282233681, 99913.0, 100204.0, 103635.0, 103733.0, 62919.99999999908, 82681.0, 83531.0, 85912.57043714741, 87301.56349218213, 63256.0, 72959.27040729631, 74898.0, 75496.0, 76323.23676763273, 11055.944720276348, 11992.0, 12034.819477708017, 12264.87735122673, 12371.566995155126, 31962.52056219112, 33087.172820679676, 33526.0, 33813.0, 35073.64926350806, 60243.0, 60956.39043609507, 63025.68487157535, 63752.3624763765, 68099.0, 16699.24853381625, 16719.414820481226, 16787.32850685959, 16898.831011689726, 17041.233144508777, 19860.60278794387, 20197.394078177676, 20277.391678249085, 20281.08735106953, 20365.592688145858, 16559.66880662356, 16670.916645416695, 16811.41160059392, 16895.817292789387, 17319.30722771075, 18151.183196756443, 18383.356582519547, 18506.352277670216, 18753.90623046876, 18849.90575047116, 16900.408485703432, 17815.10924453798, 18308.450746477625, 18311.267549297878, 18425.81574184241, 12028.639140825439, 12304.384780760747, 12426.192297500633, 12585.370731463574, 12618.936905315415, 13140.145890517086, 13280.468781248643, 13442.865571344553, 13782.7595516404, 13895.791563126359], "value": 8683.553653721658, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 109.0, 107.0, 108.0, 108.0, 109.0, 108.0, 111.0, 111.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 147.0, 182.0, 124.0, 153.0, 152.0, 125.0, 169.0, 120.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 161.0, 160.0, 161.0, 171.0, 166.0, 162.0, 166.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 153.0, 75.0, 76.0, 75.0, 74.0, 99.0, 75.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 136.0, 81.0, 83.0, 82.0, 134.0, 81.0, 82.0, 130.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 149.0, 150.0, 149.0, 151.0, 149.0, 149.0, 150.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 56.0, 61.0, 57.0, 54.0, 56.0, 55.0, 59.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 78.0, 78.0, 81.0, 81.0, 80.0, 79.0, 77.0, 77.0, 80.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 129.0, 126.0, 126.0, 127.0, 129.0, 127.0, 126.0, 129.0, 167.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 187.0, 188.0, 190.0, 186.0, 190.0, 196.0, 182.0, 194.0, 188.0], "value": 189.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 67.0, 68.0, 72.0, 68.0, 71.0, 67.0, 68.0, 67.0], "value": 68.6, "unit": "score"}]}]} 09:56:56 INFO - Return code: 0 09:56:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:56:56 INFO - # TBPL SUCCESS # 09:56:56 INFO - Running post-action listener: _resource_record_post_action 09:56:56 INFO - [mozharness: 2017-06-27 16:56:56.728565Z] Finished run-tests step (success) 09:56:56 INFO - Running post-run listener: _resource_record_post_run 09:56:56 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 12288; Write bytes: 446693376; Read time: 112; Write time: 297900 09:56:56 INFO - TinderboxPrint: CPU usage
13.1% 09:56:56 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 112 09:56:56 INFO - TinderboxPrint: I/O write bytes / time
446,693,376 / 297,900 09:56:56 INFO - TinderboxPrint: CPU idle
8,293.0 (86.9%) 09:56:56 INFO - TinderboxPrint: CPU user
1,205.2 (12.6%) 09:56:56 INFO - TinderboxPrint: Swap in / out
0 / 0 09:56:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 119595008; Read time: 96; Write time: 96600 09:56:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:56:56 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326279168; Read time: 8; Write time: 201240 09:56:57 INFO - Running post-run listener: _upload_blobber_files 09:56:57 INFO - Blob upload gear active. 09:56:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:56:57 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:56:57 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:56:57 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:56:57 INFO - (blobuploader) - INFO - Open directory for files ... 09:56:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:56:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:56:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:58 INFO - (blobuploader) - INFO - Done attempting. 09:56:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:56:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:56:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:59 INFO - (blobuploader) - INFO - Done attempting. 09:56:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:56:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:57:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:02 INFO - (blobuploader) - INFO - Done attempting. 09:57:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:57:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:57:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:03 INFO - (blobuploader) - INFO - Done attempting. 09:57:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:57:03 INFO - Return code: 0 09:57:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:57:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:57:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/303bba86a9b39710a761d74ec90b2ed2ce54564302d141c8b3effd5ec2d3a281f3cbf75862b244b1b4f0ce7d80792ddc9fa828f1700f0ca6ec9f631bf2234be8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6de36237cf5c07190cea07f2bfffaae51b96272397f02081e14e6c881d60c941e872b8b9950bbb4942d109c1ec02d175012fe852f2101a93f80626bc6b43566f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd79a5b696755c45ca2b447870aaf28e5b68088dc42b81bc1f18819f0f018dff0055e66c0f0f7d786c525a88802564ed867faea0c52bdfe344484c978142ad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/851ae9ccf72adac326476a091b7737363188464c49b1739f61cc0b70b03b082c7fa5bf290b601f25ef107aea5fbb7f7700fe59890c088e066c394912841ad395"} 09:57:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:57:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:57:03 INFO - Contents: 09:57:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/303bba86a9b39710a761d74ec90b2ed2ce54564302d141c8b3effd5ec2d3a281f3cbf75862b244b1b4f0ce7d80792ddc9fa828f1700f0ca6ec9f631bf2234be8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6de36237cf5c07190cea07f2bfffaae51b96272397f02081e14e6c881d60c941e872b8b9950bbb4942d109c1ec02d175012fe852f2101a93f80626bc6b43566f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd79a5b696755c45ca2b447870aaf28e5b68088dc42b81bc1f18819f0f018dff0055e66c0f0f7d786c525a88802564ed867faea0c52bdfe344484c978142ad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/851ae9ccf72adac326476a091b7737363188464c49b1739f61cc0b70b03b082c7fa5bf290b601f25ef107aea5fbb7f7700fe59890c088e066c394912841ad395"} 09:57:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:57:03 INFO - Copying logs to upload dir... 09:57:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:57:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.075407 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-06-27 09:57:02.144142) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-27 09:57:02.147261) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/303bba86a9b39710a761d74ec90b2ed2ce54564302d141c8b3effd5ec2d3a281f3cbf75862b244b1b4f0ce7d80792ddc9fa828f1700f0ca6ec9f631bf2234be8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6de36237cf5c07190cea07f2bfffaae51b96272397f02081e14e6c881d60c941e872b8b9950bbb4942d109c1ec02d175012fe852f2101a93f80626bc6b43566f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd79a5b696755c45ca2b447870aaf28e5b68088dc42b81bc1f18819f0f018dff0055e66c0f0f7d786c525a88802564ed867faea0c52bdfe344484c978142ad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/851ae9ccf72adac326476a091b7737363188464c49b1739f61cc0b70b03b082c7fa5bf290b601f25ef107aea5fbb7f7700fe59890c088e066c394912841ad395"} build_url:https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/ebqFHG3gQ76gsR6ghI9XMQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/303bba86a9b39710a761d74ec90b2ed2ce54564302d141c8b3effd5ec2d3a281f3cbf75862b244b1b4f0ce7d80792ddc9fa828f1700f0ca6ec9f631bf2234be8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6de36237cf5c07190cea07f2bfffaae51b96272397f02081e14e6c881d60c941e872b8b9950bbb4942d109c1ec02d175012fe852f2101a93f80626bc6b43566f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd79a5b696755c45ca2b447870aaf28e5b68088dc42b81bc1f18819f0f018dff0055e66c0f0f7d786c525a88802564ed867faea0c52bdfe344484c978142ad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/851ae9ccf72adac326476a091b7737363188464c49b1739f61cc0b70b03b082c7fa5bf290b601f25ef107aea5fbb7f7700fe59890c088e066c394912841ad395"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-27 09:57:02.175390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-27 09:57:02.175745) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1498581366.596150-1740687721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-27 09:57:02.258017) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-27 09:57:02.258366) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-27 09:57:02.258687) ========= ========= Total master_lag: 0.16 =========