builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-082 starttime: 1496942226.24 results: success (0) revision: e61060be36424240058f8bef4c5597f401bc8b7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-08 10:17:06.235556) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-08 10:17:06.235994) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-08 10:17:06.236280) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-08 10:17:06.255436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 10:17:06.255727) ========= 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=51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-08 10:17:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-06-08 10:17:06 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139721 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 10:17:06.408569) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 10:17:06.408878) ========= 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=51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017657 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 10:17:06.460607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-08 10:17:06.460915) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e61060be36424240058f8bef4c5597f401bc8b7e --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 e61060be36424240058f8bef4c5597f401bc8b7e --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=51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-08 10:17:07,066 truncating revision to first 12 chars 2017-06-08 10:17:07,066 Setting DEBUG logging. 2017-06-08 10:17:07,066 attempt 1/10 2017-06-08 10:17:07,066 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e61060be3642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-08 10:17:07,958 unpacking tar archive at: mozilla-central-e61060be3642/testing/mozharness/ program finished with exit code 0 elapsedTime=1.277881 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-08 10:17:07.754068) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-08 10:17:07.755521) ========= script_repo_revision: e61060be36424240058f8bef4c5597f401bc8b7e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-08 10:17:07.755911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-08 10:17:07.756507) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-08 10:17:07.766310) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2017-06-08 10:17:07.766576) ========= /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=51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:17:08 INFO - MultiFileLogger online at 20170608 10:17:08 in /builds/slave/test 10:17:08 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 10:17:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:17:08 INFO - {'append_to_log': False, 10:17:08 INFO - 'base_work_dir': '/builds/slave/test', 10:17:08 INFO - 'blob_upload_branch': 'Firefox', 10:17:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:17:08 INFO - 'branch': 'Firefox', 10:17:08 INFO - 'buildbot_json_path': 'buildprops.json', 10:17:08 INFO - 'config_files': ('talos/linux_config.py',), 10:17:08 INFO - 'default_actions': ('clobber', 10:17:08 INFO - 'read-buildbot-config', 10:17:08 INFO - 'download-and-extract', 10:17:08 INFO - 'populate-webroot', 10:17:08 INFO - 'create-virtualenv', 10:17:08 INFO - 'install', 10:17:08 INFO - 'setup-mitmproxy', 10:17:08 INFO - 'run-tests'), 10:17:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:17:08 INFO - 'download_minidump_stackwalk': True, 10:17:08 INFO - 'download_symbols': 'ondemand', 10:17:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:17:08 INFO - 'tooltool.py': '/tools/tooltool.py', 10:17:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:17:08 INFO - '/tools/misc-python/virtualenv.py')}, 10:17:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:17:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:17:08 INFO - 'gecko_profile': False, 10:17:08 INFO - 'gecko_profile_interval': 0, 10:17:08 INFO - 'installer_path': 'installer.exe', 10:17:08 INFO - 'log_level': 'info', 10:17:08 INFO - 'log_name': 'talos', 10:17:08 INFO - 'log_to_console': True, 10:17:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:17:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:17:08 INFO - 'opt_config_files': (), 10:17:08 INFO - 'pip_index': False, 10:17:08 INFO - 'suite': 'dromaeojs-e10s', 10:17:08 INFO - 'system_bits': '32', 10:17:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:17:08 INFO - 'title': 'talos-linux64-ix-082', 10:17:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:17:08 INFO - 'use_talos_json': True, 10:17:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:17:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:17:08 INFO - 'work_dir': 'build'} 10:17:08 INFO - [mozharness: 2017-06-08 17:17:08.472563Z] Running clobber step. 10:17:08 INFO - Running pre-action listener: _resource_record_pre_action 10:17:08 INFO - Running main action method: clobber 10:17:08 INFO - rmtree: /builds/slave/test/build 10:17:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:17:09 INFO - Running post-action listener: _resource_record_post_action 10:17:09 INFO - [mozharness: 2017-06-08 17:17:09.489193Z] Finished clobber step (success) 10:17:09 INFO - [mozharness: 2017-06-08 17:17:09.489294Z] Running read-buildbot-config step. 10:17:09 INFO - Running pre-action listener: _resource_record_pre_action 10:17:09 INFO - Running main action method: read_buildbot_config 10:17:09 INFO - Using buildbot properties: 10:17:09 INFO - { 10:17:09 INFO - "project": "", 10:17:09 INFO - "product": "firefox", 10:17:09 INFO - "who": "ffxbld@noreply.mozilla.org", 10:17:09 INFO - "installer_path": "public/build/target.tar.bz2", 10:17:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:17:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:17:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:17:09 INFO - "stage_platform": "linux64-pgo", 10:17:09 INFO - "basedir": "/builds/slave/test", 10:17:09 INFO - "buildnumber": 1, 10:17:09 INFO - "platform": "ubuntu64_hw", 10:17:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:17:09 INFO - "slavebuilddir": "test", 10:17:09 INFO - "taskId": "db-tMSb9RnS0GIIc750NcA", 10:17:09 INFO - "branch": "mozilla-central", 10:17:09 INFO - "script_repo_revision": "production", 10:17:09 INFO - "revision": "e61060be36424240058f8bef4c5597f401bc8b7e", 10:17:09 INFO - "slavename": "talos-linux64-ix-082", 10:17:09 INFO - "repo_path": "mozilla-central" 10:17:09 INFO - } 10:17:09 INFO - Finding installer, test and symbols from parent task. 10:17:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/db-tMSb9RnS0GIIc750NcA'}, attempt #1 10:17:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/db-tMSb9RnS0GIIc750NcA'}, attempt #1 10:17:10 INFO - Task dependencies: KZS2N_p7TtCtogQghTyqYw 10:17:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw'}, attempt #1 10:17:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.tar.bz2 10:17:10 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/test_packages.json 10:17:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.crashreporter-symbols.zip 10:17:10 INFO - Running post-action listener: _resource_record_post_action 10:17:10 INFO - [mozharness: 2017-06-08 17:17:10.938630Z] Finished read-buildbot-config step (success) 10:17:10 INFO - [mozharness: 2017-06-08 17:17:10.938851Z] Running download-and-extract step. 10:17:10 INFO - Running pre-action listener: _resource_record_pre_action 10:17:10 INFO - Running main action method: download_and_extract 10:17:10 INFO - mkdir: /builds/slave/test/build/tests 10:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:10 INFO - trying https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.test_packages.json 10:17:10 INFO - Downloading https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:17:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:17:11 INFO - Downloaded 989 bytes. 10:17:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:17:11 INFO - Using the following test package requirements: 10:17:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:17:11 INFO - u'common': [u'target.common.tests.zip'], 10:17:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:17:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:17:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:17:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:17:11 INFO - u'mozbase': [u'target.common.tests.zip'], 10:17:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:17:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:17:11 INFO - u'web-platform': [u'target.common.tests.zip', 10:17:11 INFO - u'target.web-platform.tests.tar.gz'], 10:17:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:17:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:17:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.common.tests.zip 10:17:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:17:11 INFO - Fetch https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.common.tests.zip into memory 10:17:12 INFO - Content-Length response header: 68492081 10:17:12 INFO - Bytes received: 68492081 10:17:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:17:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.common.tests.zip 10:17:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:17:23 INFO - Fetch https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.common.tests.zip into memory 10:17:24 INFO - Content-Length response header: 68492081 10:17:24 INFO - Bytes received: 68492081 10:17:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.talos.tests.zip 10:17:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:17:37 INFO - Fetch https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.talos.tests.zip into memory 10:17:37 INFO - Content-Length response header: 14447568 10:17:37 INFO - Bytes received: 14447568 10:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:38 INFO - trying https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.tar.bz2 10:17:38 INFO - Downloading https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:17:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:17:39 INFO - Downloaded 59797525 bytes. 10:17:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.tar.bz2 10:17:39 INFO - mkdir: /builds/slave/test/properties 10:17:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:17:39 INFO - Writing to file /builds/slave/test/properties/build_url 10:17:39 INFO - Contents: 10:17:39 INFO - build_url:https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.tar.bz2 10:17:39 INFO - Running post-action listener: _resource_record_post_action 10:17:39 INFO - Running post-action listener: set_extra_try_arguments 10:17:39 INFO - [mozharness: 2017-06-08 17:17:39.166512Z] Finished download-and-extract step (success) 10:17:39 INFO - [mozharness: 2017-06-08 17:17:39.166608Z] Running populate-webroot step. 10:17:39 INFO - Running pre-action listener: _resource_record_pre_action 10:17:39 INFO - Running main action method: populate_webroot 10:17:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:17:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:17:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:17:39 INFO - '--tppagecycles', 10:17:39 INFO - '7'], 10:17:39 INFO - 'tests': ['tsvgm']}}, 10:17:39 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:17:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:17:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:17:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:17:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:17:39 INFO - 'talos_options': ['--disable-e10s'], 10:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:17:39 INFO - 'talos_options': ['--disable-e10s'], 10:17:39 INFO - 'tests': ['damp', 'tps']}, 10:17:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:17:39 INFO - 'tests': ['damp', 'tps']}, 10:17:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:17:39 INFO - 'tests': ['dromaeo_dom']}, 10:17:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:17:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:17:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:17:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:17:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:17:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:17:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:17:39 INFO - 'tests': ['a11yr', 10:17:39 INFO - 'ts_paint', 10:17:39 INFO - 'tpaint', 10:17:39 INFO - 'sessionrestore', 10:17:39 INFO - 'sessionrestore_no_auto_restore', 10:17:39 INFO - 'tabpaint']}, 10:17:39 INFO - 'other-e10s': {'tests': ['a11yr', 10:17:39 INFO - 'ts_paint', 10:17:39 INFO - 'tpaint', 10:17:39 INFO - 'sessionrestore', 10:17:39 INFO - 'sessionrestore_no_auto_restore', 10:17:39 INFO - 'tabpaint']}, 10:17:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:17:39 INFO - 'ts_paint', 10:17:39 INFO - 'tpaint', 10:17:39 INFO - 'sessionrestore', 10:17:39 INFO - 'sessionrestore_no_auto_restore', 10:17:39 INFO - 'tabpaint']}, 10:17:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:17:39 INFO - 'ts_paint', 10:17:39 INFO - 'tpaint', 10:17:39 INFO - 'sessionrestore', 10:17:39 INFO - 'sessionrestore_no_auto_restore', 10:17:39 INFO - 'tabpaint']}, 10:17:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:17:39 INFO - 'tests': ['a11yr', 10:17:39 INFO - 'ts_paint', 10:17:39 INFO - 'tpaint', 10:17:39 INFO - 'sessionrestore', 10:17:39 INFO - 'sessionrestore_no_auto_restore', 10:17:39 INFO - 'tabpaint']}, 10:17:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:17:39 INFO - 'tests': ['a11yr', 10:17:39 INFO - 'ts_paint', 10:17:39 INFO - 'tpaint', 10:17:39 INFO - 'sessionrestore', 10:17:39 INFO - 'sessionrestore_no_auto_restore', 10:17:39 INFO - 'tabpaint']}, 10:17:39 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:17:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:17:39 INFO - 'bloom_basic_ref']}, 10:17:39 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 10:17:39 INFO - 'talos_options': ['--mitmproxy', 10:17:39 INFO - 'mitmproxy-recording-1.mp', 10:17:39 INFO - '--firstNonBlankPaint'], 10:17:39 INFO - 'tests': ['Quantum_1']}, 10:17:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:17:39 INFO - 'tests': ['tsvgx', 10:17:39 INFO - 'tsvgr_opacity', 10:17:39 INFO - 'tart', 10:17:39 INFO - 'tscrollx', 10:17:39 INFO - 'cart', 10:17:39 INFO - 'tsvg_static']}, 10:17:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:17:39 INFO - 'tsvgr_opacity', 10:17:39 INFO - 'tart', 10:17:39 INFO - 'tscrollx', 10:17:39 INFO - 'cart', 10:17:39 INFO - 'tsvg_static']}, 10:17:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:17:39 INFO - 'talos_options': ['--disable-e10s'], 10:17:39 INFO - 'tests': ['tp5o']}, 10:17:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:17:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:17:39 INFO - 'talos_options': ['--disable-e10s', 10:17:39 INFO - '--xperf_path', 10:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:39 INFO - 'tests': ['tp5n']}, 10:17:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:17:39 INFO - 'talos_options': ['--xperf_path', 10:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:39 INFO - 'tests': ['tp5n']}}, 10:17:39 INFO - 'talos.zip': {'path': '', 10:17:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:17:39 INFO - Running post-action listener: _resource_record_post_action 10:17:39 INFO - [mozharness: 2017-06-08 17:17:39.180977Z] Finished populate-webroot step (success) 10:17:39 INFO - [mozharness: 2017-06-08 17:17:39.181072Z] Running create-virtualenv step. 10:17:39 INFO - Running pre-action listener: _resource_record_pre_action 10:17:39 INFO - Running main action method: create_virtualenv 10:17:39 INFO - Creating virtualenv /builds/slave/test/build/venv 10:17:39 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 10:17:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:17:39 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:17:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:17:39 INFO - Using real prefix '/usr' 10:17:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:17:39 INFO - Installing distribute.............................................................................................................................................................................................done. 10:17:41 INFO - Installing pip.................done. 10:17:41 INFO - Return code: 0 10:17:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:17:41 INFO - Reading from file tmpfile_stdout 10:17:41 INFO - Output received: 10:17:41 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) 10:17:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e140>, '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 0x1c4ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4eed0>, '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': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', '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 10:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:17:41 INFO - Using env: {'DISPLAY': ':0', 10:17:41 INFO - 'HOME': '/home/cltbld', 10:17:41 INFO - 'LANG': 'en_US.UTF-8', 10:17:41 INFO - 'LANGUAGE': 'en_US:en', 10:17:41 INFO - 'LOGNAME': 'cltbld', 10:17:41 INFO - 'MAIL': '/var/mail/cltbld', 10:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:41 INFO - 'MOZ_NO_REMOTE': '1', 10:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:41 INFO - 'NO_EM_RESTART': '1', 10:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:41 INFO - 'PWD': '/builds/slave/test', 10:17:41 INFO - 'SHELL': '/bin/bash', 10:17:41 INFO - 'SHLVL': '1', 10:17:41 INFO - 'TERM': 'linux', 10:17:41 INFO - 'TMOUT': '86400', 10:17:41 INFO - 'USER': 'cltbld', 10:17:41 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', 10:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:41 INFO - '_': '/tools/buildbot/bin/python'} 10:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:42 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 10:17:42 INFO - Cleaning up... 10:17:42 INFO - Return code: 0 10:17:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:17:42 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')]} 10:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:42 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')]} 10:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:42 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 0x18d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e140>, '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 0x1c4ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4eed0>, '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': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', '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 10:17:42 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 10:17:42 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 10:17:42 INFO - Using env: {'DISPLAY': ':0', 10:17:42 INFO - 'HOME': '/home/cltbld', 10:17:42 INFO - 'LANG': 'en_US.UTF-8', 10:17:42 INFO - 'LANGUAGE': 'en_US:en', 10:17:42 INFO - 'LOGNAME': 'cltbld', 10:17:42 INFO - 'MAIL': '/var/mail/cltbld', 10:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:42 INFO - 'MOZ_NO_REMOTE': '1', 10:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:42 INFO - 'NO_EM_RESTART': '1', 10:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:42 INFO - 'PWD': '/builds/slave/test', 10:17:42 INFO - 'SHELL': '/bin/bash', 10:17:42 INFO - 'SHLVL': '1', 10:17:42 INFO - 'TERM': 'linux', 10:17:42 INFO - 'TMOUT': '86400', 10:17:42 INFO - 'USER': 'cltbld', 10:17:42 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', 10:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:42 INFO - '_': '/tools/buildbot/bin/python'} 10:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:42 INFO - Downloading/unpacking psutil>=3.1.1 10:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:17:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:43 INFO - Installing collected packages: psutil 10:17:43 INFO - Running setup.py install for psutil 10:17:43 INFO - building 'psutil._psutil_linux' extension 10:17:43 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 10:17:43 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 10:17:43 INFO - building 'psutil._psutil_posix' extension 10:17:43 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 10:17:43 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 10:17:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:44 INFO - Successfully installed psutil 10:17:44 INFO - Cleaning up... 10:17:44 INFO - Return code: 0 10:17:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:44 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 0x18d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e140>, '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 0x1c4ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4eed0>, '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': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', '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 10:17:44 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 10:17:44 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 10:17:44 INFO - Using env: {'DISPLAY': ':0', 10:17:44 INFO - 'HOME': '/home/cltbld', 10:17:44 INFO - 'LANG': 'en_US.UTF-8', 10:17:44 INFO - 'LANGUAGE': 'en_US:en', 10:17:44 INFO - 'LOGNAME': 'cltbld', 10:17:44 INFO - 'MAIL': '/var/mail/cltbld', 10:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:44 INFO - 'MOZ_NO_REMOTE': '1', 10:17:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:44 INFO - 'NO_EM_RESTART': '1', 10:17:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:44 INFO - 'PWD': '/builds/slave/test', 10:17:44 INFO - 'SHELL': '/bin/bash', 10:17:44 INFO - 'SHLVL': '1', 10:17:44 INFO - 'TERM': 'linux', 10:17:44 INFO - 'TMOUT': '86400', 10:17:44 INFO - 'USER': 'cltbld', 10:17:44 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', 10:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:44 INFO - '_': '/tools/buildbot/bin/python'} 10:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:17:44 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 10:17:44 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 10:17:44 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 10:17:44 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 10:17:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:17:45 INFO - Installing collected packages: mozsystemmonitor 10:17:45 INFO - Running setup.py install for mozsystemmonitor 10:17:45 INFO - Successfully installed mozsystemmonitor 10:17:45 INFO - Cleaning up... 10:17:45 INFO - Return code: 0 10:17:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17: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', '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 0x18d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e140>, '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 0x1c4ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4eed0>, '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': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', '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 10:17: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:17: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 jsonschema==2.5.1 10:17:45 INFO - Using env: {'DISPLAY': ':0', 10:17:45 INFO - 'HOME': '/home/cltbld', 10:17:45 INFO - 'LANG': 'en_US.UTF-8', 10:17:45 INFO - 'LANGUAGE': 'en_US:en', 10:17:45 INFO - 'LOGNAME': 'cltbld', 10:17:45 INFO - 'MAIL': '/var/mail/cltbld', 10:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:45 INFO - 'MOZ_NO_REMOTE': '1', 10:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:45 INFO - 'NO_EM_RESTART': '1', 10:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:45 INFO - 'PWD': '/builds/slave/test', 10:17:45 INFO - 'SHELL': '/bin/bash', 10:17:45 INFO - 'SHLVL': '1', 10:17:45 INFO - 'TERM': 'linux', 10:17:45 INFO - 'TMOUT': '86400', 10:17:45 INFO - 'USER': 'cltbld', 10:17:45 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', 10:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:45 INFO - '_': '/tools/buildbot/bin/python'} 10:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:45 INFO - Downloading/unpacking jsonschema==2.5.1 10:17: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 10:17: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 10:17: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 10:17: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 10:17:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:17:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:17: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 10:17: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 10:17: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 10:17: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 10:17:47 INFO - Downloading functools32-3.2.3-2.tar.gz 10:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:17:47 INFO - warning: no files found matching '*.txt' 10:17:47 INFO - no previously-included directories found matching 'build' 10:17:47 INFO - no previously-included directories found matching 'dist' 10:17:47 INFO - no previously-included directories found matching '.git*' 10:17:47 INFO - Installing collected packages: jsonschema, functools32 10:17:47 INFO - Running setup.py install for functools32 10:17:47 INFO - warning: no files found matching '*.txt' 10:17:47 INFO - no previously-included directories found matching 'build' 10:17:47 INFO - no previously-included directories found matching 'dist' 10:17:47 INFO - no previously-included directories found matching '.git*' 10:17:47 INFO - Successfully installed jsonschema functools32 10:17:47 INFO - Cleaning up... 10:17:47 INFO - Return code: 0 10:17:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:47 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 0x18d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e140>, '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 0x1c4ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4eed0>, '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': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', '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 10:17:47 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 10:17:47 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 10:17:47 INFO - Using env: {'DISPLAY': ':0', 10:17:47 INFO - 'HOME': '/home/cltbld', 10:17:47 INFO - 'LANG': 'en_US.UTF-8', 10:17:47 INFO - 'LANGUAGE': 'en_US:en', 10:17:47 INFO - 'LOGNAME': 'cltbld', 10:17:47 INFO - 'MAIL': '/var/mail/cltbld', 10:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:47 INFO - 'MOZ_NO_REMOTE': '1', 10:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:47 INFO - 'NO_EM_RESTART': '1', 10:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:47 INFO - 'PWD': '/builds/slave/test', 10:17:47 INFO - 'SHELL': '/bin/bash', 10:17:47 INFO - 'SHLVL': '1', 10:17:47 INFO - 'TERM': 'linux', 10:17:47 INFO - 'TMOUT': '86400', 10:17:47 INFO - 'USER': 'cltbld', 10:17:47 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', 10:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:47 INFO - '_': '/tools/buildbot/bin/python'} 10:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:17:47 INFO - Cleaning up... 10:17:47 INFO - Return code: 0 10:17:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:47 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 0x18d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e140>, '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 0x1c4ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4eed0>, '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': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', '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 10:17:47 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 10:17:47 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 10:17:47 INFO - Using env: {'DISPLAY': ':0', 10:17:47 INFO - 'HOME': '/home/cltbld', 10:17:47 INFO - 'LANG': 'en_US.UTF-8', 10:17:47 INFO - 'LANGUAGE': 'en_US:en', 10:17:47 INFO - 'LOGNAME': 'cltbld', 10:17:47 INFO - 'MAIL': '/var/mail/cltbld', 10:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:47 INFO - 'MOZ_NO_REMOTE': '1', 10:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:47 INFO - 'NO_EM_RESTART': '1', 10:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:47 INFO - 'PWD': '/builds/slave/test', 10:17:47 INFO - 'SHELL': '/bin/bash', 10:17:47 INFO - 'SHLVL': '1', 10:17:47 INFO - 'TERM': 'linux', 10:17:47 INFO - 'TMOUT': '86400', 10:17:47 INFO - 'USER': 'cltbld', 10:17:47 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', 10:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:47 INFO - '_': '/tools/buildbot/bin/python'} 10:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:47 INFO - Downloading/unpacking blobuploader==1.2.4 10:17:47 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 10:17:47 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 10:17:47 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 10:17:47 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 10:17:48 INFO - Downloading blobuploader-1.2.4.tar.gz 10:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:17:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:17: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 10:17: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 10:17: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 10:17: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 10:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:17:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:49 INFO - Downloading docopt-0.6.1.tar.gz 10:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:17:49 INFO - Installing collected packages: blobuploader, requests, docopt 10:17:49 INFO - Running setup.py install for blobuploader 10:17:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:17:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:17:49 INFO - Running setup.py install for requests 10:17:49 INFO - Running setup.py install for docopt 10:17:49 INFO - Successfully installed blobuploader requests docopt 10:17:49 INFO - Cleaning up... 10:17:50 INFO - Return code: 0 10:17:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:50 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 0x18d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e140>, '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 0x1c4ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4eed0>, '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': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', '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 10:17:50 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 10:17:50 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 10:17:50 INFO - Using env: {'DISPLAY': ':0', 10:17:50 INFO - 'HOME': '/home/cltbld', 10:17:50 INFO - 'LANG': 'en_US.UTF-8', 10:17:50 INFO - 'LANGUAGE': 'en_US:en', 10:17:50 INFO - 'LOGNAME': 'cltbld', 10:17:50 INFO - 'MAIL': '/var/mail/cltbld', 10:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:50 INFO - 'MOZ_NO_REMOTE': '1', 10:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:50 INFO - 'NO_EM_RESTART': '1', 10:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:50 INFO - 'PWD': '/builds/slave/test', 10:17:50 INFO - 'SHELL': '/bin/bash', 10:17:50 INFO - 'SHLVL': '1', 10:17:50 INFO - 'TERM': 'linux', 10:17:50 INFO - 'TMOUT': '86400', 10:17:50 INFO - 'USER': 'cltbld', 10:17:50 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', 10:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:50 INFO - '_': '/tools/buildbot/bin/python'} 10:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:50 INFO - Running setup.py (path:/tmp/pip-_R0xMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:50 INFO - Running setup.py (path:/tmp/pip-ndJa_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:50 INFO - Running setup.py (path:/tmp/pip-MaFirv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:50 INFO - Running setup.py (path:/tmp/pip-LnDIx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:50 INFO - Running setup.py (path:/tmp/pip-KvLBDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:50 INFO - Running setup.py (path:/tmp/pip-N127nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:50 INFO - Running setup.py (path:/tmp/pip-UoNXwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:50 INFO - Running setup.py (path:/tmp/pip-IPo32w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:50 INFO - Running setup.py (path:/tmp/pip-j4kaRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:50 INFO - Running setup.py (path:/tmp/pip-8bV5BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:50 INFO - Running setup.py (path:/tmp/pip-yN_sfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:51 INFO - Running setup.py (path:/tmp/pip-S_7u1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:51 INFO - Running setup.py (path:/tmp/pip-XGpE1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:51 INFO - Running setup.py (path:/tmp/pip-FAIaVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:51 INFO - Running setup.py (path:/tmp/pip-WMh0T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:51 INFO - Running setup.py (path:/tmp/pip-bLhIK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:51 INFO - Running setup.py (path:/tmp/pip-bO0IGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:17:51 INFO - Running setup.py install for manifestparser 10:17:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Running setup.py install for mozcrash 10:17:51 INFO - Running setup.py install for mozdebug 10:17:51 INFO - Running setup.py install for mozdevice 10:17:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:17:51 INFO - Running setup.py install for mozfile 10:17:51 INFO - Running setup.py install for mozhttpd 10:17:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Running setup.py install for mozinfo 10:17:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Running setup.py install for mozInstall 10:17:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Running setup.py install for mozleak 10:17:52 INFO - Running setup.py install for mozlog 10:17:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Running setup.py install for moznetwork 10:17:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Running setup.py install for mozprocess 10:17:52 INFO - Running setup.py install for mozprofile 10:17:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Running setup.py install for mozrunner 10:17:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:17:52 INFO - Running setup.py install for mozscreenshot 10:17:53 INFO - Running setup.py install for moztest 10:17:53 INFO - Running setup.py install for mozversion 10:17:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:17:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:17:53 INFO - Cleaning up... 10:17:53 INFO - Return code: 0 10:17:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:53 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')]} 10:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:53 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')]} 10:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:53 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 0x18d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e140>, '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 0x1c4ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4eed0>, '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': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', '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 10:17:53 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 10:17:53 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 10:17:53 INFO - Using env: {'DISPLAY': ':0', 10:17:53 INFO - 'HOME': '/home/cltbld', 10:17:53 INFO - 'LANG': 'en_US.UTF-8', 10:17:53 INFO - 'LANGUAGE': 'en_US:en', 10:17:53 INFO - 'LOGNAME': 'cltbld', 10:17:53 INFO - 'MAIL': '/var/mail/cltbld', 10:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:53 INFO - 'MOZ_NO_REMOTE': '1', 10:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:53 INFO - 'NO_EM_RESTART': '1', 10:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:53 INFO - 'PWD': '/builds/slave/test', 10:17:53 INFO - 'SHELL': '/bin/bash', 10:17:53 INFO - 'SHLVL': '1', 10:17:53 INFO - 'TERM': 'linux', 10:17:53 INFO - 'TMOUT': '86400', 10:17:53 INFO - 'USER': 'cltbld', 10:17:53 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', 10:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:53 INFO - '_': '/tools/buildbot/bin/python'} 10:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:53 INFO - Running setup.py (path:/tmp/pip-CPEISd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:53 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)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:53 INFO - Running setup.py (path:/tmp/pip-OiEExE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:53 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)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:53 INFO - Running setup.py (path:/tmp/pip-eqRE35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:53 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)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:53 INFO - Running setup.py (path:/tmp/pip-gHz7pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:53 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)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:53 INFO - Running setup.py (path:/tmp/pip-MAiVR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:53 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)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:53 INFO - Running setup.py (path:/tmp/pip-DJT00y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:53 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)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:53 INFO - Running setup.py (path:/tmp/pip-GTfBP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:53 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)) 10:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:53 INFO - Running setup.py (path:/tmp/pip-BxuMDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:54 INFO - Running setup.py (path:/tmp/pip-9304Yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:54 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)) 10:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:54 INFO - Running setup.py (path:/tmp/pip-aVUIcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:54 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)) 10:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:54 INFO - Running setup.py (path:/tmp/pip-xnrlbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:54 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)) 10:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:54 INFO - Running setup.py (path:/tmp/pip-PFKQxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:54 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)) 10:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:54 INFO - Running setup.py (path:/tmp/pip-jRXjaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:54 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)) 10:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:54 INFO - Running setup.py (path:/tmp/pip-7ac9dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:54 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)) 10:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:54 INFO - Running setup.py (path:/tmp/pip-0AX3JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:54 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)) 10:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:54 INFO - Running setup.py (path:/tmp/pip-ivq0TG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:54 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)) 10:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:54 INFO - Running setup.py (path:/tmp/pip-43jHwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:54 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)) 10:17:54 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)) 10:17:54 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)) 10:17:54 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)) 10:17:54 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)) 10:17:54 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)) 10:17:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:17:54 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 10:17:54 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 10:17:54 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 10:17:54 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 10:17:55 INFO - Downloading blessings-1.6.tar.gz 10:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:17:55 INFO - Installing collected packages: blessings 10:17:55 INFO - Running setup.py install for blessings 10:17:55 INFO - Successfully installed blessings 10:17:55 INFO - Cleaning up... 10:17:56 INFO - Return code: 0 10:17:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:17:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:56 INFO - Reading from file tmpfile_stdout 10:17:56 INFO - Current package versions: 10:17:56 INFO - argparse == 1.2.1 10:17:56 INFO - blessings == 1.6 10:17:56 INFO - blobuploader == 1.2.4 10:17:56 INFO - docopt == 0.6.1 10:17:56 INFO - functools32 == 3.2.3-2 10:17:56 INFO - jsonschema == 2.5.1 10:17:56 INFO - manifestparser == 1.1 10:17:56 INFO - mozInstall == 1.12 10:17:56 INFO - mozcrash == 1.0 10:17:56 INFO - mozdebug == 0.1 10:17:56 INFO - mozdevice == 0.51 10:17:56 INFO - mozfile == 1.2 10:17:56 INFO - mozhttpd == 0.7 10:17:56 INFO - mozinfo == 0.10 10:17:56 INFO - mozleak == 0.1 10:17:56 INFO - mozlog == 3.4 10:17:56 INFO - moznetwork == 0.27 10:17:56 INFO - mozprocess == 0.25 10:17:56 INFO - mozprofile == 0.28 10:17:56 INFO - mozrunner == 6.13 10:17:56 INFO - mozscreenshot == 0.1 10:17:56 INFO - mozsystemmonitor == 0.3 10:17:56 INFO - moztest == 0.8 10:17:56 INFO - mozversion == 1.4 10:17:56 INFO - psutil == 3.1.1 10:17:56 INFO - requests == 1.2.3 10:17:56 INFO - wsgiref == 0.1.2 10:17:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:56 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')]} 10:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:56 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')]} 10:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:56 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 0x18d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e140>, '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 0x1c4ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4eed0>, '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': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', '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 10:17:56 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 10:17:56 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 10:17:56 INFO - Using env: {'DISPLAY': ':0', 10:17:56 INFO - 'HOME': '/home/cltbld', 10:17:56 INFO - 'LANG': 'en_US.UTF-8', 10:17:56 INFO - 'LANGUAGE': 'en_US:en', 10:17:56 INFO - 'LOGNAME': 'cltbld', 10:17:56 INFO - 'MAIL': '/var/mail/cltbld', 10:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:56 INFO - 'MOZ_NO_REMOTE': '1', 10:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:56 INFO - 'NO_EM_RESTART': '1', 10:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:56 INFO - 'PWD': '/builds/slave/test', 10:17:56 INFO - 'SHELL': '/bin/bash', 10:17:56 INFO - 'SHLVL': '1', 10:17:56 INFO - 'TERM': 'linux', 10:17:56 INFO - 'TMOUT': '86400', 10:17:56 INFO - 'USER': 'cltbld', 10:17:56 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', 10:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:56 INFO - '_': '/tools/buildbot/bin/python'} 10:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:56 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)) 10:17:56 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)) 10:17:56 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)) 10:17:56 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)) 10:17:56 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)) 10:17:56 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)) 10:17:56 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)) 10:17:56 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)) 10:17:56 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)) 10:17:56 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:17:56 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 10:17:56 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 10:17:56 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 10:17:56 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 10:17:57 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:17:57 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)) 10:17:57 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)) 10:17:57 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)) 10:17:57 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)) 10:17:57 INFO - Installing collected packages: marionette-driver 10:17:57 INFO - Running setup.py install for marionette-driver 10:17:57 INFO - Successfully installed marionette-driver 10:17:57 INFO - Cleaning up... 10:17:57 INFO - Return code: 0 10:17:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e140>, '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 0x1c4ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4eed0>, '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': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', '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 10:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:17:57 INFO - Using env: {'DISPLAY': ':0', 10:17:57 INFO - 'HOME': '/home/cltbld', 10:17:57 INFO - 'LANG': 'en_US.UTF-8', 10:17:57 INFO - 'LANGUAGE': 'en_US:en', 10:17:57 INFO - 'LOGNAME': 'cltbld', 10:17:57 INFO - 'MAIL': '/var/mail/cltbld', 10:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:57 INFO - 'MOZ_NO_REMOTE': '1', 10:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:57 INFO - 'NO_EM_RESTART': '1', 10:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:57 INFO - 'PWD': '/builds/slave/test', 10:17:57 INFO - 'SHELL': '/bin/bash', 10:17:57 INFO - 'SHLVL': '1', 10:17:57 INFO - 'TERM': 'linux', 10:17:57 INFO - 'TMOUT': '86400', 10:17:57 INFO - 'USER': 'cltbld', 10:17:57 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', 10:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:57 INFO - '_': '/tools/buildbot/bin/python'} 10:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:17:57 INFO - Cleaning up... 10:17:58 INFO - Return code: 0 10:17:58 INFO - Running post-action listener: _resource_record_post_action 10:17:58 INFO - Running post-action listener: _start_resource_monitoring 10:17:58 INFO - Starting resource monitoring. 10:17:58 INFO - [mozharness: 2017-06-08 17:17:58.033412Z] Finished create-virtualenv step (success) 10:17:58 INFO - [mozharness: 2017-06-08 17:17:58.033873Z] Running install step. 10:17:58 INFO - Running pre-action listener: _resource_record_pre_action 10:17:58 INFO - Running main action method: install 10:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:58 INFO - Reading from file tmpfile_stdout 10:17:58 INFO - Detecting whether we're running mozinstall >=1.0... 10:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:17:58 INFO - Reading from file tmpfile_stdout 10:17:58 INFO - Output received: 10:17:58 INFO - Usage: mozinstall [options] installer 10:17:58 INFO - Options: 10:17:58 INFO - -h, --help show this help message and exit 10:17:58 INFO - -d DEST, --destination=DEST 10:17:58 INFO - Directory to install application into. [default: 10:17:58 INFO - "/builds/slave/test"] 10:17:58 INFO - --app=APP Application being installed. [default: firefox] 10:17:58 INFO - mkdir: /builds/slave/test/build/application 10:17:58 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'] 10:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:18:15 INFO - Reading from file tmpfile_stdout 10:18:15 INFO - Output received: 10:18:15 INFO - /builds/slave/test/build/application/firefox/firefox 10:18:15 INFO - Running post-action listener: _resource_record_post_action 10:18:15 INFO - [mozharness: 2017-06-08 17:18:15.269356Z] Finished install step (success) 10:18:15 INFO - [mozharness: 2017-06-08 17:18:15.269631Z] Running setup-mitmproxy step. 10:18:15 INFO - Running pre-action listener: _resource_record_pre_action 10:18:15 INFO - Running main action method: setup_mitmproxy 10:18:15 INFO - Skipping: mitmproxy is not required 10:18:15 INFO - Running post-action listener: _resource_record_post_action 10:18:15 INFO - [mozharness: 2017-06-08 17:18:15.270762Z] Finished setup-mitmproxy step (success) 10:18:15 INFO - [mozharness: 2017-06-08 17:18:15.270984Z] Running run-tests step. 10:18:15 INFO - Running pre-action listener: _resource_record_pre_action 10:18:15 INFO - Running main action method: run_tests 10:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:18:15 INFO - Python 2.7.3 10:18:15 INFO - Return code: 0 10:18:15 INFO - grabbing minidump binary from tooltool 10:18:15 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')]} 10:18:15 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 0x1c4e140>, '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 0x1c4ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4eed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:18:15 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 10:18:15 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 10:18:15 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 10:18:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:18:15 INFO - Return code: 0 10:18:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:18:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:18:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:18:15 INFO - ENV: RUST_BACKTRACE is now 1 10:18:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:18:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:18:15 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/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 10:18:15 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/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --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 10:18:15 INFO - Using env: {'DISPLAY': ':0', 10:18:15 INFO - 'HOME': '/home/cltbld', 10:18:15 INFO - 'LANG': 'en_US.UTF-8', 10:18:15 INFO - 'LANGUAGE': 'en_US:en', 10:18:15 INFO - 'LOGNAME': 'cltbld', 10:18:15 INFO - 'MAIL': '/var/mail/cltbld', 10:18:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:18:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:15 INFO - 'MOZ_NO_REMOTE': '1', 10:18:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:15 INFO - 'NO_EM_RESTART': '1', 10:18:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:15 INFO - 'PWD': '/builds/slave/test', 10:18:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:18:15 INFO - 'RUST_BACKTRACE': '1', 10:18:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:18:15 INFO - 'SHELL': '/bin/bash', 10:18:15 INFO - 'SHLVL': '1', 10:18:15 INFO - 'TERM': 'linux', 10:18:15 INFO - 'TMOUT': '86400', 10:18:15 INFO - 'USER': 'cltbld', 10:18:15 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320', 10:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:15 INFO - '_': '/tools/buildbot/bin/python'} 10:18:15 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/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 10:18:15 INFO - mozversion application_buildid: 20170608162720 10:18:15 INFO - mozversion application_changeset: e61060be36424240058f8bef4c5597f401bc8b7e 10:18:15 INFO - mozversion application_display_name: Nightly 10:18:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:18:15 INFO - mozversion application_name: Firefox 10:18:15 INFO - mozversion application_remotingname: firefox 10:18:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:18:15 INFO - mozversion application_vendor: Mozilla 10:18:15 INFO - mozversion application_version: 55.0a1 10:18:15 INFO - mozversion platform_buildid: 20170608162720 10:18:15 INFO - mozversion platform_changeset: e61060be36424240058f8bef4c5597f401bc8b7e 10:18:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:18:15 INFO - mozversion platform_version: 55.0a1 10:18:15 INFO - using testdate: 1496942295 10:18:15 INFO - actual date: 1496942295 10:18:15 INFO - starting webserver on 'localhost:55438' 10:18:15 INFO - SUITE-START | Running 2 tests 10:18:15 INFO - TEST-START | dromaeo_css 10:18:15 INFO - operating with platform_type : linux_ 10:18:15 INFO - Initialising browser for dromaeo_css test... 10:18:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55438/getInfo.html -profile /tmp/tmp4G989X/profile 10:18:15 INFO - TEST-INFO | started process 21760 (/builds/slave/test/build/application/firefox/firefox http://localhost:55438/getInfo.html) 10:18:50 INFO - TEST-INFO | 21760: killed by SIGTERM 10:18:50 INFO - Browser initialized. 10:18:50 INFO - Running cycle 1/1 for dromaeo_css test... 10:18:50 INFO - TEST-INFO | started process 21969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4G989X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:01 INFO - PID 21969 | RSS: Main: 177213440 10:19:01 INFO - PID 21969 | 10:22:02 INFO - PID 21969 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55438/tests/dromaeo/cssquery-ext.html) 10:22:03 INFO - PID 21969 | RSS: Main: 176599040 10:22:03 INFO - PID 21969 | 10:25:05 INFO - PID 21969 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-ext.html (next: http://localhost:55438/tests/dromaeo/cssquery-jquery.html) 10:25:06 INFO - PID 21969 | RSS: Main: 178532352 10:25:06 INFO - PID 21969 | 10:28:07 INFO - PID 21969 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55438/tests/dromaeo/cssquery-mootools.html) 10:28:08 INFO - PID 21969 | RSS: Main: 178511872 10:28:08 INFO - PID 21969 | 10:31:10 INFO - PID 21969 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55438/tests/dromaeo/cssquery-prototype.html) 10:31:10 INFO - PID 21969 | RSS: Main: 179404800 10:31:10 INFO - PID 21969 | 10:34:13 INFO - PID 21969 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55438/tests/dromaeo/cssquery-yui.html) 10:34:13 INFO - PID 21969 | RSS: Main: 180695040 10:34:13 INFO - PID 21969 | 10:37:15 INFO - PID 21969 | Cycle 1(1): loaded http://localhost:55438/tests/dromaeo/cssquery-yui.html (next: http://localhost:55438/tests/dromaeo/cssquery-dojo.html) 10:37:15 INFO - PID 21969 | RSS: Main: 177254400 10:37:15 INFO - PID 21969 | 10:37:15 INFO - PID 21969 | __start_tp_report 10:37:15 INFO - PID 21969 | _x_x_mozilla_page_load 10:37:15 INFO - PID 21969 | _x_x_mozilla_page_load_details 10:37:15 INFO - PID 21969 | |i|pagename|runs| 10:37:15 INFO - PID 21969 | |0;dojo.html;3368.0401085690582;3408;3442.60410052844;3458.4120699481086;3459.7232221422287;6005.279366476024;6029.849253768658;6047.9999999999945;6057.757689692418;6083.452489275965;6013.488853447451;6058.636481811094;6072.939270607292;6087.269527656687;6092.299385570661;5360.65155764876;5408.810691625794;5409.188621706756;5446.2375267462585;5450.482204190595;5444.183372494138;5467.152591348347;5471.124620060791;5486.698231597261;5494.450554944514;5408.378036525791;5423.105187644034;5437.537809286196;5470.617056806005;5495.835124946258;5401.918971215435;5445.727713614304;5483.99999999998;5498;5501.174823776446;5366.275552800361;5391.865203369908;5429.728513574345;5444.591655625804;5447.836564903059;6012.18835457212;6021.277446706379;6120.112583675342;6125.019996800491;6134.355892631299;6449.83875403114;6495.253045899687;6528.93471065288;6569.178852643419;6575.3095924927675;6532.11816404784;6538.476921846241;6540.93459065408;6556.475481961479;6573.046908198285;6049.879002419971;6061.727222275008;6075.848103797441;6106.786262480792;6124.479419249369;5613.7193140342815;6601.207855057424;6686.331366863372;6722.327767223239;6835.692393842289;6485.643289619022;6490.643014634146;6492.5455218134275;6494.188226471691;6516.902246466307;6474.773382931575;6559.048937903977;6597.571157874723;6623.07276981223;6643.667816609151;6462.806115816533;6463;6506.056621789814;6589.83525411859;6601.207855057328;5670.659760414388;6172.876542469216;6588.934110658832;6601.8349541260895;6633.900491492632;4888.804447822118;4912.606991440676;4938.975305123451;4941.234108713155;4964.131277026506;4336.82652693895;4342.891427714332;4360.847370342023;4375.431193944767;4378.737275763465;6065.6663883486835;6103.115048317969;6131.264248290234;6131.529590167202;6131.724072416752;6463.15978922737;6508.479321654351;6521.347865213535;6535.738570457223;6546.803595892131;6038.516918646497;6083.148359229712;6115.449609535163;6124.968882250436;6140.385961403913;5546.029444847136;5569.749361278752;5570.470805273492;5572.3034620672415;5574.414686457944;6706.362895524917;6766.661666916536;6797.5921444712485;6904.654767261617;6923.2038315594355;6506.837329066811;6528.053432252392;6529.281779004401;6531.2489063756375;6547.738090476328;5328.920066199088;6664.866702666017;6674.733010679518;6686.732530698912;6719.059331693665;6529.8694026120165;6537.411632953057;6555.508336874849;6556.508261880474;6560.803175904731;6663.067170596218;6695.631740254333;6699.631520266237;6710.731570737116;6711.697973591103;6342;6440.484761219185;6484.5460817742305;6490.707918143789;6515.0553169791065;6398.1362516059735;6439.259485159267;6468.353164683682;6476.352364763486;6478.060681201294;6307.779227727007;6342.936570634419;6396.42432181106;6400.263969643551;6423;6509.1863517060365;6517.348265173445;6522.478201743944;6527.51043671717;6530.08578798959;6283.37166283368;6305.558610897193;6315.463185629273;6322.462590679844;6337.746490140527 10:37:15 INFO - PID 21969 | |1;ext.html;774.3495463810401;812.1431889356726;842.3429724814645;856.6573370651738;857.8756080368347;36403.45394819076;37277;37376;37440.812795935984;37506;34352.31295374097;34448.31103377931;34582.481262781075;34723.30553388931;34744.30511389771;6292.370762923717;6405.263394709598;6405.647689377082;6408.10286559882;6412.935870641304;6222.439980401763;6275.435210831024;6298.181236439256;6302.747890084391;6315.90526142106;6243.906341404882;6247.812565623039;6260.060990851363;6272.686365681698;6297.023961286008;6230.968845155768;6264.937350626504;6267.6866156691985;6271.435570798627;6280.811575652738;5841.4450627190345;5904.321003084658;5909.645421274694;6568.704408301638;7081.575105493687;35215.1196220094;35431.82284088563;35440.822795885855;35531.644683553095;35572.28855422877;3465.4455287153933;3496.125968507873;3532.346515894568;3533.487644291589;3534.0988048047584;27564.586531202047;27792.444151117066;27929.86035069832;27957.440851183066;28002.299942501395;3204.070819462353;3290.2596915694016;3291.53918451417;3307.074019274607;3317.5853018372704;174525;175488;176526.99999999872;202941;204736;39994.80002600027;42625.78687106607;43693;45658.31512527315;45916.39292624742;47785;47826.5217347822;47837.043259134625;47838.76080619644;47885.28172077422;15174.165420901956;15225.923870380577;15232;15242.542723718307;15297.9235103826;12384.690382740504;12408.317542535247;12422.937885310515;12424.440900159514;12427.130100892851;13772.931135344259;13818.585442436743;13901.79147312791;13989.3704783285;14093.78859317111;5604.663720176803;5645.689487078168;5729;5817.243758311477;5847.795327163529;1046.942418167008;1053.8155822730992;1057.259918057363;1066.4987455895716;1070.314998401024;23451.648225276633;23451.88274058619;23852.64221036686;24330.635040474408;24550.386240343778;1103.9779204416027;1119.587289391363;1149.2127892393737;1175.723704929341;1177.8468799056238;12565.371731413392;13041.804372934414;13042.347882606022;13138.277394743382;13166.539171128965;255946;256338;256979;257233;257722;48843;49170;49358.25962610564;49376;49435.258471122965;1410.5133728863525;1499.182945294817;1506.058713304185;1511.2443778110944;1514.2882845062802;23558.528829422972;23708.88145559261;23720.288391348287;23734.762652373254;24105.517889641756;35854.64145358618;36143;36209.63790362063;36224.818875905454;36280.45579316365;216610;217145;217566;217871;218465;30386.84806575953;32003.35993280168;32216.516752248266;32422.513662294612;32577.837110815242;37625;39758.2048359037;40544.391834121925;40578;40620.1875962485;28411;29477;30317.69682303149;30909.845450772602;31444.056678299687;29972.85013574918;30455.543166852956;31389.52915706312;31484;32136.696048163296;35857.82071089628;36545.634543654225;37235;37253.25493490169;37365.065873353386;29044.27389315284;29288.121356359345;30123.849380753833;30567.23581910381;31119.377612448076;24790.38024049413;25044.74955250497;25550.616740748534;25551.361215969748;25715.485690286463 10:37:15 INFO - PID 21969 | |2;jquery.html;506.2381116419788;520.0768635671682;520.3157847430629;529.5287194396986;539.2908325551897;19756.407307780755;19844.90077549614;20058.799412005876;20746.688799668016;20775.16899324027;22170.778292217074;22654.88672556639;22778.65832012521;22786.2024829131;22835.429114272152;5568.1091025435935;5719.628224165437;5755.079187330028;5756.798512052079;5763.279590051244;5544.0575102232715;5601.047821870271;5606.327240731098;5626.381098079208;5630.09918413054;5159.793608255665;5557.055300598888;5566;5585.944140558583;5632.859178520529;5579.414161513044;5598.804041858536;5606.607537472379;5614.803481878114;5636.91544626833;5219.112750832368;5226.817061402832;5226.92159617606;5237.764300606444;5257.789688412459;25243.242702718948;25562.23313300604;25596.48807023849;25601.10396136145;25776.48447031049;2111.271611294101;2200.614892393841;2202.977970220293;2204.2285200179967;2227.6992605998144;17434.564135896577;17651.117444127744;17744.290228390848;17774.55563610907;17782;2191.2659259148045;2207.834412419075;2220.222921977311;2247.2808701215617;2281.771822817705;107547.46226268896;113340.4332978338;113713;119725.40137299345;129658.40683186284;13429.39567719455;13503.852172565443;13730.794038089436;14151.858481415054;14434.206118663575;20370.083346249456;20382.592348152953;20419.8979005107;20428;20441.591168176554;9289.767755806159;9445.952770236105;9550.323125596557;9575.856362154573;9643.373180743229;8627.48235105883;8673.176048275403;8738.563071846509;8824.426412283181;8864.246539044125;8548.658053677907;8617.138286171457;8711.34664900135;8719.60761765722;8765.649374025095;2543.300592337122;2553.553128202557;2565.4869026194838;2579.8839052242693;2620.3318153871023;1005.1556692378438;1014.8442129479769;1019.9031092046243;1035.6582327831798;1076.3810808784824;19232.423027309203;19838.305659301855;19906.50233744168;19987.60024799496;20210.79789202089;1035.404642330663;1043.1602559939322;1057.545255540125;1069.9625513107003;1071.3571856885962;10603.257771955889;10693.395990601472;10720.517576709066;10850.837237441445;10868.184886133571;481192;484871;491339;493866;496774;106669.46665266623;107663;108995;110135;110273.44863275792;1187.228301603947;1188.233589334874;1212.2665787198794;1223.1132428988913;1230.852297724261;17086.91456542759;17146;17572;19059;20597;48772;52431.737841312075;53577.732111339195;53967.73016134894;55241.44758552524;63864;64335.678321608095;64406.67796660987;64583.67708161429;64605;11650.242734222249;11675.591354302558;11757.882421175678;11761.764764704487;11783.52865885355;17103.657926841144;18083.909580452015;18124.27502899869;18383;18385.90807045956;12325.322107284186;12844;13011.544595939096;13068.934655326662;13230.206187628773;12766.936165319114;13471.663208419868;13798.862011379757;13995.650108747363;14027.859721403063;12908.935455322664;13641.249731264876;14467.92766036163;14649.92675036618;14779.408823646934;11045.889541104487;11070.612528561784;11182.32906025641;11214.102871770076;11229.27009744364;13671.316434178052;13680.179189248676;13719.45122195101;13759.931200343934;13762.931185344009 10:37:15 INFO - PID 21969 | |3;mootools.html;1442.2500299844082;1503.759398496241;1507.0957425544675;1516.8179818421784;1529.8623123918849;13117.278549679764;13656.658583535393;13667.589972300822;13696.657583560416;13725.450981960723;11347.489362978666;11693.883061169387;11779.70550736232;11790.115741319392;11806.114541409408;2452.2030340139436;2538.860362680052;2576.046862660818;2576.7809736172353;2582.6642536470326;2557.514072326261;2593.688757349121;2598.1296265751;2603.3491627093226;2603.986980065097;2382.797462215714;2431.9756802431925;2443.609022556391;2448.2165706973774;2450.473148273121;2269.693591365161;2276.578832915916;2281.9885900570475;2288.6452599846966;2321.6285394336824;2305.054927479742;2333.3233362324904;2352.0591763294647;2354;2362.8582285062953;13179.209247445087;13206.73586528264;13279.73440531184;13316.800247996287;13328.933355333258;7173.390261827751;7410.925890741078;7423.480356375056;7423.888641670379;7450.739224127184;4104.507459104897;4281.828726850922;4346.630536404409;4378.956210437918;4424.491183513873;1438.6906815034713;1472.0505274098148;1476.616079819244;1477.8300495443054;1493.6415260337549;21778.128874845144;21790.346289611178;21905.671414928787;21938;21946.780532194793;6453.903191452132;6566.5403421760975;6610.933890661032;6779.72881084751;6830.863382732317;17449.21478533469;17493.82506174922;17505.649887002444;17511.299548018193;17572.82427175712;7484.850302993909;7567.848643027109;7577.204393538599;7578.317951384402;7598.962005189938;6633.170853643294;6698.698558564876;6768.898466523006;6913.481488888354;7023.473239507058;4685;4773.140834649727;4910.48439913811;5214.9478505214465;5349.251104845324;1555.4866893924977;1564.1475395909256;1570.6780110077407;1572.709048825971;1603.5590212691602;924.177482040984;924.8381533231658;937.1471960515897;955.3790036476346;973.1047436358567;7991.200879912079;8339.291160251447;8911.465312081296;8984.910150898539;8990.595423205972;714.1002337055347;734.0823970037453;741.2994719989558;745.571296504512;1005.8491226315965;4634.83778067766;4945.357103576512;5027.195648696191;5096.51583099605;5141.408737995103;17883.910580447013;18109.36617218391;18700.438986830417;18704.345347912757;18711.251549938122;17926.91036544809;18073.909630451762;18191.818081819278;18324.083795810155;18332.54168645768;10215.846762298572;10424.68725938223;10469;10663.306885052447;10784.191185661106;8038.155993620586;8062.355011599176;8281;8324.209200125979;8586.239820836588;15353;15780.763288550452;16096.597585059999;16454.917725411295;16503.422380216634;15187.840150052592;16332.101734404721;16361.427350042692;16471.094089825176;16536.338546458006;12342.382880855741;12688.936555317534;12812.423440945366;12965.935170324465;12990.285534295326;11474.770504589695;11790.823137652771;11825.290482570728;11838.467268972745;12942.676433089247;9390.530473476163;9605.567749451431;9685.757856053655;10137.493125343852;10481.161507079567;10003.849942250727;10165.390076595428;10322.638707645498;10346.37921724699;10519.421431821018;8998.64005439775;9012.32407569448;9074.137956894085;9116.08839116083;9201;6751.594904305757;6964.721411143701;7031.718731250693;7188.928110718826;7381.741639042608;7156.141263048467;7378.778636640909;7447.664855081643;7487.138979017265;7668.233176682287 10:37:15 INFO - PID 21969 | |4;prototype.html;459.54045954045955;472.2703423211141;486.25845585482136;491.518312054187;492.94577596464404;6202.813915582534;6282.732978851001;6286.8113956581265;6289.559730818844;6336.873262534747;5907.970460147704;6013.609115407496;6054.848628784272;6080.483158931496;6115.908261376083;4864;4968.006398720252;4984.925226121611;5001.774920128585;5041.193409054552;4974.850754477371;4977.47736487669;4984.102861484931;4988.2766998785155;4992.700437973715;4920.507949205086;4938.48145944676;4951.356323677916;4993.425756038047;4996.375453068366;4949.331840201563;4949.480304568005;4955.058538877602;4961.412348048626;4963.2058870580895;4356.172327257811;4419.315006174048;4450.1767173073085;4493.236149854532;4509.819607215707;6060.727267272983;6061.848453788646;6083.178770865965;6093.756249750049;6094.238220222473;5937.406259374028;5938.079597662369;5957.463828255434;5968.4031596840405;5988.251468566429;6624.205095388585;6634.800955971328;6637.601743895333;6682.933170668328;6685.93314066858;5095;5108.259302401131;5139.357580302462;5143.074246635604;5166.870828229286;6878.896816547755;6880.65596720162;6895.586264824126;6898.965505172492;6908.620025898574;5298.2052692096495;5313.468653134656;5316.0962636351915;5327.706976116351;5332.253484512172;5382.1119515280325;5382.407935127133;5390.733177703237;5396.757145928443;5411.918821217685;5910.556708246899;5915.142304365843;5917.674527900921;5921.940780592225;5954.432605513858;6658.833529161713;6659.766908158192;6661.16735408074;6672.7330906764155;6680.5991640501725;1875.7467741854948;1898.250191174506;1899.886006839594;1899.9265415040459;1902.1345287893976;1158.8609366876028;1223.113242898909;1226.9938650306692;1227.1348699167065;1233.309346765814;5873.3245676746865;6216.270237857249;6246.75012999484;6283.340249273851;6289.465395441347;6764.797056088325;6787.490938179656;6788.355106264897;6806.081179040865;6806.897896531556;6048.455638992512;6051.515878729691;6091.878162436727;6128.417800308964;6141.324454310023;3530.0821786335737;3537.3809583322814;3564.6078931317534;3584.408572585546;3604.621514740967;6909.481788865754;6992;7001.369876711018;7019.578825270398;7022.789316320519;6849.089137116705;6895.931040689629;6904.171499420102;6910.2053263874295;6945;6836.487263455261;6905.792826215121;6941.965290173517;6973.302669732986;6982.720691172398;6664.233613134357;6700.128983232149;6730.192376914802;6730.192376914802;6733.293004234485;6710.396064354231;6724.394804467622;6736.675846832834;6738.079647300496;6744.022116793136;6940.791776246519;6977.406920411619;6987.650617469005;6996.965015174892;7013.509054366349;4938.2839488273285;4952.257161425671;4956.231784073474;4978.7510624467905;4984.651074424755;6383.755167742245;6746.426553742791;6804.96597517029;6814.727410903508;6850.691718872762;6237.4698150657705;6578.835529111619;6587.604743715392;6588.903215488713;6599.67001649906;6569.80290591283;6593.011048342787;6630.403263706289;6635.942857714124;6642.376261376826;6488.805335839932;6500.187476565429;6517.7067031984625;6520.510961677798;6543.70553325111;6554.344565543408;6559.704813283318;6586.4401525870835;6591.802245932629;6600.438962688033;6343.492520598434;6398.488120950406;6429.7428102875365;6442.484601231984;6462.095306657166 10:37:15 INFO - PID 21969 | |5;yui.html;827.1893544326564;860.2172023458658;867.7049803066956;870.4429165334187;873.0178549132227;17043.233054512544;17280.22238999245;17436.476905692816;17715.291388344453;17744.46766597001;12933.094683372168;13298.335083245847;13767;14700.852991470083;14724.19016954067;743.423846518948;907.63694522191;912.9132732390445;1015.1726343030407;1016.6797458800454;1006.6225165562914;1014.9492525373739;1015.3095894791538;1015.725754046407;1017.1455976979336;1062.984055239172;1064.9946750266276;1069.8127827630133;1069.9732506687355;1070.7055559721061;1057.106744800646;1062.6227689170387;1063.3619828103153;1063.4416931111114;1065.3128731967838;549.5356423821864;561.9662820230799;564.7712676366078;778.5951305321202;779.672537534237;13228.140170888957;16316.918415407847;16947.40684076064;16964.151792410332;17071.914640426843;17987.910060449743;18069.864416090317;19238.422847314603;19428.90285548563;19447.124879380463;12545.247285162919;12673.746525069539;12729.490820367268;12914.612561623073;12931.870681293254;3331.716804071657;3355.0773537277446;3385.7460690448315;3386.0349800306794;3387.0177648481913;73258.63370683113;102809.80917913321;104746.47626761894;104905;106964.46517767438;12411.62765117048;12621.432035558422;14147.504837330644;14724.411023559152;14858.182799946107;26583.601245981325;27064;27520.724792751815;27747.028853990014;27798.305042373697;8032.236937490929;8163.224493673091;8196.385271104691;8203.220694034057;8236.752897413087;3919.510061242345;3996.8401263949117;4036.334004889219;4037.4953130858644;4041.1715598302276;4647.209974304376;4686.906261874743;4796.424429068534;4803.759812009385;4908.852734417973;968.9660861869942;987.1017374189453;1004.2919741582167;1004.4626125023077;1006.436395618456;654.0646874968745;661.3750006244053;661.9139511863523;670.165643773505;682.0825989044727;11637.522095612983;12135.393230338448;12416.875831241572;12487.625371238877;13563.932180339232;723.8479919217024;730.3353947907378;730.831908661011;734.8346622010112;747.4468893019126;5559.77760889568;5796.94203057964;5871.089981052944;6026.276846778414;6076.574639775174;102373;102932;106532;106997;107769;88090.55954720314;90109;90204.09795902089;92065;94561;71475.6426217876;78295;80379;81727.5913620428;82048.58975705084;12020.098492613264;12317.260964342167;12377.319247441477;12599;12714.427850746924;31595.684043159275;39142.80428597839;39200.411993820686;39477.802610987914;41100.58899411087;61904.38095618986;61992.380076198664;62909.37090629035;66819;68123;18033.639327213645;18203.726944096114;18408.723869142243;18601.53496162607;18778.812211877706;18130.546736331697;19037.333693320666;19142.425727228205;19370;19665.311714089938;19427;19449.222031118596;19701.310454134036;19752.209911603375;19810.40568782939;18098.185581648595;18466.722999154754;18679.439616811516;18732.344367947055;18990.050497475346;18106.72839907376;18419.171137299123;19133.712994305373;19304.806951930863;19332.90333548323;13039.608811735663;13441.059125861097;13645.454181832616;13898.722025559635;14278.714425711636;13200.867991319963;13308.407887123152;13573.321333933462;13632.591022269347;13770.727829907953 10:37:15 INFO - PID 21969 | __end_tp_report 10:37:15 INFO - PID 21969 | __start_cc_report 10:37:15 INFO - PID 21969 | _x_x_mozilla_cycle_collect,323 10:37:15 INFO - PID 21969 | __end_cc_report 10:37:15 INFO - PID 21969 | __startTimestamp1496943435965__endTimestamp 10:37:15 INFO - PID 21969 | 10:37:15 INFO - PID 21969 | ------- Summary: start ------- 10:37:15 INFO - PID 21969 | Number of tests: 6 10:37:15 INFO - PID 21969 | 10:37:15 INFO - PID 21969 | [#0] dojo.html Cycles:165 Average:6034.04 Median:6315.46 stddev:735.70 (11.6%) stddev-sans-first:707.61 10:37:15 INFO - PID 21969 | Values: 3368.0 3408.0 3442.6 3458.4 3459.7 6005.3 6029.8 6048.0 6057.8 6083.5 6013.5 6058.6 6072.9 6087.3 6092.3 5360.7 5408.8 5409.2 5446.2 5450.5 5444.2 5467.2 5471.1 5486.7 5494.5 5408.4 5423.1 5437.5 5470.6 5495.8 5401.9 5445.7 5484.0 5498.0 5501.2 5366.3 5391.9 5429.7 5444.6 5447.8 6012.2 6021.3 6120.1 6125.0 6134.4 6449.8 6495.3 6528.9 6569.2 6575.3 6532.1 6538.5 6540.9 6556.5 6573.0 6049.9 6061.7 6075.8 6106.8 6124.5 5613.7 6601.2 6686.3 6722.3 6835.7 6485.6 6490.6 6492.5 6494.2 6516.9 6474.8 6559.0 6597.6 6623.1 6643.7 6462.8 6463.0 6506.1 6589.8 6601.2 5670.7 6172.9 6588.9 6601.8 6633.9 4888.8 4912.6 4939.0 4941.2 4964.1 4336.8 4342.9 4360.8 4375.4 4378.7 6065.7 6103.1 6131.3 6131.5 6131.7 6463.2 6508.5 6521.3 6535.7 6546.8 6038.5 6083.1 6115.4 6125.0 6140.4 5546.0 5569.7 5570.5 5572.3 5574.4 6706.4 6766.7 6797.6 6904.7 6923.2 6506.8 6528.1 6529.3 6531.2 6547.7 5328.9 6664.9 6674.7 6686.7 6719.1 6529.9 6537.4 6555.5 6556.5 6560.8 6663.1 6695.6 6699.6 6710.7 6711.7 6342.0 6440.5 6484.5 6490.7 6515.1 6398.1 6439.3 6468.4 6476.4 6478.1 6307.8 6342.9 6396.4 6400.3 6423.0 6509.2 6517.3 6522.5 6527.5 6530.1 6283.4 6305.6 6315.5 6322.5 6337.7 10:37:15 INFO - PID 21969 | 10:37:15 INFO - PID 21969 | [#1] ext.html Cycles:180 Average:37471.47 Median:17934.05 stddev:57873.91 (322.7%) stddev-sans-first:57970.67 10:37:15 INFO - PID 21969 | Values: 774.3 812.1 842.3 856.7 857.9 36403.5 37277.0 37376.0 37440.8 37506.0 34352.3 34448.3 34582.5 34723.3 34744.3 6292.4 6405.3 6405.6 6408.1 6412.9 6222.4 6275.4 6298.2 6302.7 6315.9 6243.9 6247.8 6260.1 6272.7 6297.0 6231.0 6264.9 6267.7 6271.4 6280.8 5841.4 5904.3 5909.6 6568.7 7081.6 35215.1 35431.8 35440.8 35531.6 35572.3 3465.4 3496.1 3532.3 3533.5 3534.1 27564.6 27792.4 27929.9 27957.4 28002.3 3204.1 3290.3 3291.5 3307.1 3317.6 174525.0 175488.0 176527.0 202941.0 204736.0 39994.8 42625.8 43693.0 45658.3 45916.4 47785.0 47826.5 47837.0 47838.8 47885.3 15174.2 15225.9 15232.0 15242.5 15297.9 12384.7 12408.3 12422.9 12424.4 12427.1 13772.9 13818.6 13901.8 13989.4 14093.8 5604.7 5645.7 5729.0 5817.2 5847.8 1046.9 1053.8 1057.3 1066.5 1070.3 23451.6 23451.9 23852.6 24330.6 24550.4 1104.0 1119.6 1149.2 1175.7 1177.8 12565.4 13041.8 13042.3 13138.3 13166.5 255946.0 256338.0 256979.0 257233.0 257722.0 48843.0 49170.0 49358.3 49376.0 49435.3 1410.5 1499.2 1506.1 1511.2 1514.3 23558.5 23708.9 23720.3 23734.8 24105.5 35854.6 36143.0 36209.6 36224.8 36280.5 216610.0 217145.0 217566.0 217871.0 218465.0 30386.8 32003.4 32216.5 32422.5 32577.8 37625.0 39758.2 40544.4 40578.0 40620.2 28411.0 29477.0 30317.7 30909.8 31444.1 29972.9 30455.5 31389.5 31484.0 32136.7 35857.8 36545.6 37235.0 37253.3 37365.1 29044.3 29288.1 30123.8 30567.2 31119.4 24790.4 25044.7 25550.6 25551.4 25715.5 10:37:15 INFO - PID 21969 | 10:37:15 INFO - PID 21969 | [#2] jquery.html Cycles:180 Average:32281.88 Median:20434.80 stddev:81839.34 (400.5%) stddev-sans-first:82034.14 10:37:15 INFO - PID 21969 | Values: 506.2 520.1 520.3 529.5 539.3 19756.4 19844.9 20058.8 20746.7 20775.2 22170.8 22654.9 22778.7 22786.2 22835.4 5568.1 5719.6 5755.1 5756.8 5763.3 5544.1 5601.0 5606.3 5626.4 5630.1 5159.8 5557.1 5566.0 5585.9 5632.9 5579.4 5598.8 5606.6 5614.8 5636.9 5219.1 5226.8 5226.9 5237.8 5257.8 25243.2 25562.2 25596.5 25601.1 25776.5 2111.3 2200.6 2203.0 2204.2 2227.7 17434.6 17651.1 17744.3 17774.6 17782.0 2191.3 2207.8 2220.2 2247.3 2281.8 107547.5 113340.4 113713.0 119725.4 129658.4 13429.4 13503.9 13730.8 14151.9 14434.2 20370.1 20382.6 20419.9 20428.0 20441.6 9289.8 9446.0 9550.3 9575.9 9643.4 8627.5 8673.2 8738.6 8824.4 8864.2 8548.7 8617.1 8711.3 8719.6 8765.6 2543.3 2553.6 2565.5 2579.9 2620.3 1005.2 1014.8 1019.9 1035.7 1076.4 19232.4 19838.3 19906.5 19987.6 20210.8 1035.4 1043.2 1057.5 1070.0 1071.4 10603.3 10693.4 10720.5 10850.8 10868.2 481192.0 484871.0 491339.0 493866.0 496774.0 106669.5 107663.0 108995.0 110135.0 110273.4 1187.2 1188.2 1212.3 1223.1 1230.9 17086.9 17146.0 17572.0 19059.0 20597.0 48772.0 52431.7 53577.7 53967.7 55241.4 63864.0 64335.7 64406.7 64583.7 64605.0 11650.2 11675.6 11757.9 11761.8 11783.5 17103.7 18083.9 18124.3 18383.0 18385.9 12325.3 12844.0 13011.5 13068.9 13230.2 12766.9 13471.7 13798.9 13995.7 14027.9 12908.9 13641.2 14467.9 14649.9 14779.4 11045.9 11070.6 11182.3 11214.1 11229.3 13671.3 13680.2 13719.5 13759.9 13762.9 10:37:15 INFO - PID 21969 | 10:37:15 INFO - PID 21969 | [#3] mootools.html Cycles:180 Average:8435.70 Median:2353.03 stddev:5712.12 (242.8%) stddev-sans-first:5703.97 10:37:15 INFO - PID 21969 | Values: 1442.3 1503.8 1507.1 1516.8 1529.9 13117.3 13656.7 13667.6 13696.7 13725.5 11347.5 11693.9 11779.7 11790.1 11806.1 2452.2 2538.9 2576.0 2576.8 2582.7 2557.5 2593.7 2598.1 2603.3 2604.0 2382.8 2432.0 2443.6 2448.2 2450.5 2269.7 2276.6 2282.0 2288.6 2321.6 2305.1 2333.3 2352.1 2354.0 2362.9 13179.2 13206.7 13279.7 13316.8 13328.9 7173.4 7410.9 7423.5 7423.9 7450.7 4104.5 4281.8 4346.6 4379.0 4424.5 1438.7 1472.1 1476.6 1477.8 1493.6 21778.1 21790.3 21905.7 21938.0 21946.8 6453.9 6566.5 6610.9 6779.7 6830.9 17449.2 17493.8 17505.6 17511.3 17572.8 7484.9 7567.8 7577.2 7578.3 7599.0 6633.2 6698.7 6768.9 6913.5 7023.5 4685.0 4773.1 4910.5 5214.9 5349.3 1555.5 1564.1 1570.7 1572.7 1603.6 924.2 924.8 937.1 955.4 973.1 7991.2 8339.3 8911.5 8984.9 8990.6 714.1 734.1 741.3 745.6 1005.8 4634.8 4945.4 5027.2 5096.5 5141.4 17883.9 18109.4 18700.4 18704.3 18711.3 17926.9 18073.9 18191.8 18324.1 18332.5 10215.8 10424.7 10469.0 10663.3 10784.2 8038.2 8062.4 8281.0 8324.2 8586.2 15353.0 15780.8 16096.6 16454.9 16503.4 15187.8 16332.1 16361.4 16471.1 16536.3 12342.4 12688.9 12812.4 12965.9 12990.3 11474.8 11790.8 11825.3 11838.5 12942.7 9390.5 9605.6 9685.8 10137.5 10481.2 10003.8 10165.4 10322.6 10346.4 10519.4 8998.6 9012.3 9074.1 9116.1 9201.0 6751.6 6964.7 7031.7 7188.9 7381.7 7156.1 7378.8 7447.7 7487.1 7668.2 10:37:15 INFO - PID 21969 | 10:37:15 INFO - PID 21969 | [#4] prototype.html Cycles:180 Average:5623.06 Median:6172.07 stddev:1581.24 (25.6%) stddev-sans-first:1537.45 10:37:15 INFO - PID 21969 | Values: 459.5 472.3 486.3 491.5 492.9 6202.8 6282.7 6286.8 6289.6 6336.9 5908.0 6013.6 6054.8 6080.5 6115.9 4864.0 4968.0 4984.9 5001.8 5041.2 4974.9 4977.5 4984.1 4988.3 4992.7 4920.5 4938.5 4951.4 4993.4 4996.4 4949.3 4949.5 4955.1 4961.4 4963.2 4356.2 4419.3 4450.2 4493.2 4509.8 6060.7 6061.8 6083.2 6093.8 6094.2 5937.4 5938.1 5957.5 5968.4 5988.3 6624.2 6634.8 6637.6 6682.9 6685.9 5095.0 5108.3 5139.4 5143.1 5166.9 6878.9 6880.7 6895.6 6899.0 6908.6 5298.2 5313.5 5316.1 5327.7 5332.3 5382.1 5382.4 5390.7 5396.8 5411.9 5910.6 5915.1 5917.7 5921.9 5954.4 6658.8 6659.8 6661.2 6672.7 6680.6 1875.7 1898.3 1899.9 1899.9 1902.1 1158.9 1223.1 1227.0 1227.1 1233.3 5873.3 6216.3 6246.8 6283.3 6289.5 6764.8 6787.5 6788.4 6806.1 6806.9 6048.5 6051.5 6091.9 6128.4 6141.3 3530.1 3537.4 3564.6 3584.4 3604.6 6909.5 6992.0 7001.4 7019.6 7022.8 6849.1 6895.9 6904.2 6910.2 6945.0 6836.5 6905.8 6942.0 6973.3 6982.7 6664.2 6700.1 6730.2 6730.2 6733.3 6710.4 6724.4 6736.7 6738.1 6744.0 6940.8 6977.4 6987.7 6997.0 7013.5 4938.3 4952.3 4956.2 4978.8 4984.7 6383.8 6746.4 6805.0 6814.7 6850.7 6237.5 6578.8 6587.6 6588.9 6599.7 6569.8 6593.0 6630.4 6635.9 6642.4 6488.8 6500.2 6517.7 6520.5 6543.7 6554.3 6559.7 6586.4 6591.8 6600.4 6343.5 6398.5 6429.7 6442.5 6462.1 10:37:15 INFO - PID 21969 | 10:37:15 INFO - PID 21969 | [#5] yui.html Cycles:180 Average:21581.44 Median:19138.07 stddev:28541.17 (149.1%) stddev-sans-first:28578.68 10:37:15 INFO - PID 21969 | Values: 827.2 860.2 867.7 870.4 873.0 17043.2 17280.2 17436.5 17715.3 17744.5 12933.1 13298.3 13767.0 14700.9 14724.2 743.4 907.6 912.9 1015.2 1016.7 1006.6 1014.9 1015.3 1015.7 1017.1 1063.0 1065.0 1069.8 1070.0 1070.7 1057.1 1062.6 1063.4 1063.4 1065.3 549.5 562.0 564.8 778.6 779.7 13228.1 16316.9 16947.4 16964.2 17071.9 17987.9 18069.9 19238.4 19428.9 19447.1 12545.2 12673.7 12729.5 12914.6 12931.9 3331.7 3355.1 3385.7 3386.0 3387.0 73258.6 102809.8 104746.5 104905.0 106964.5 12411.6 12621.4 14147.5 14724.4 14858.2 26583.6 27064.0 27520.7 27747.0 27798.3 8032.2 8163.2 8196.4 8203.2 8236.8 3919.5 3996.8 4036.3 4037.5 4041.2 4647.2 4686.9 4796.4 4803.8 4908.9 969.0 987.1 1004.3 1004.5 1006.4 654.1 661.4 661.9 670.2 682.1 11637.5 12135.4 12416.9 12487.6 13563.9 723.8 730.3 730.8 734.8 747.4 5559.8 5796.9 5871.1 6026.3 6076.6 102373.0 102932.0 106532.0 106997.0 107769.0 88090.6 90109.0 90204.1 92065.0 94561.0 71475.6 78295.0 80379.0 81727.6 82048.6 12020.1 12317.3 12377.3 12599.0 12714.4 31595.7 39142.8 39200.4 39477.8 41100.6 61904.4 61992.4 62909.4 66819.0 68123.0 18033.6 18203.7 18408.7 18601.5 18778.8 18130.5 19037.3 19142.4 19370.0 19665.3 19427.0 19449.2 19701.3 19752.2 19810.4 18098.2 18466.7 18679.4 18732.3 18990.1 18106.7 18419.2 19133.7 19304.8 19332.9 13039.6 13441.1 13645.5 13898.7 14278.7 13200.9 13308.4 13573.3 13632.6 13770.7 10:37:15 INFO - PID 21969 | -------- Summary: end -------- 10:37:15 INFO - PID 21969 | 10:37:16 INFO - TEST-INFO | 21969: exit 0 10:37:16 INFO - TEST-OK | dromaeo_css | took 1141246ms 10:37:16 INFO - TEST-START | kraken 10:37:16 INFO - operating with platform_type : linux_ 10:37:16 INFO - Initialising browser for kraken test... 10:37:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55438/getInfo.html -profile /tmp/tmp3tNl67/profile 10:37:16 INFO - TEST-INFO | started process 22389 (/builds/slave/test/build/application/firefox/firefox http://localhost:55438/getInfo.html) 10:37:51 INFO - TEST-INFO | 22389: killed by SIGTERM 10:37:51 INFO - Browser initialized. 10:37:51 INFO - Running cycle 1/1 for kraken test... 10:37:51 INFO - TEST-INFO | started process 22598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3tNl67/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:03 INFO - PID 22598 | RSS: Main: 177188864 10:38:03 INFO - PID 22598 | 10:38:05 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55438/tests/kraken/driver.html?testName=audio-beat-detection) 10:38:06 INFO - PID 22598 | RSS: Main: 180609024 10:38:06 INFO - PID 22598 | 10:38:09 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55438/tests/kraken/driver.html?testName=audio-dft) 10:38:09 INFO - PID 22598 | RSS: Main: 181403648 10:38:09 INFO - PID 22598 | 10:38:12 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55438/tests/kraken/driver.html?testName=audio-fft) 10:38:13 INFO - PID 22598 | RSS: Main: 176852992 10:38:13 INFO - PID 22598 | 10:38:15 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55438/tests/kraken/driver.html?testName=audio-oscillator) 10:38:15 INFO - PID 22598 | RSS: Main: 178561024 10:38:15 INFO - PID 22598 | 10:38:18 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:38:18 INFO - PID 22598 | RSS: Main: 178434048 10:38:18 INFO - PID 22598 | 10:38:21 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55438/tests/kraken/driver.html?testName=imaging-darkroom) 10:38:22 INFO - PID 22598 | RSS: Main: 179953664 10:38:22 INFO - PID 22598 | 10:38:25 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55438/tests/kraken/driver.html?testName=imaging-desaturate) 10:38:26 INFO - PID 22598 | RSS: Main: 180244480 10:38:26 INFO - PID 22598 | 10:38:29 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55438/tests/kraken/driver.html?testName=json-parse-financial) 10:38:29 INFO - PID 22598 | RSS: Main: 179945472 10:38:29 INFO - PID 22598 | 10:38:31 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:38:31 INFO - PID 22598 | RSS: Main: 179257344 10:38:31 INFO - PID 22598 | 10:38:33 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:38:34 INFO - PID 22598 | RSS: Main: 178925568 10:38:34 INFO - PID 22598 | 10:38:36 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:38:37 INFO - PID 22598 | RSS: Main: 179085312 10:38:37 INFO - PID 22598 | 10:38:39 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:38:40 INFO - PID 22598 | RSS: Main: 178737152 10:38:40 INFO - PID 22598 | 10:38:43 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:38:43 INFO - PID 22598 | RSS: Main: 179597312 10:38:43 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | Cycle 1(1): loaded http://localhost:55438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55438/tests/kraken/driver.html?testName=ai-astar) 10:38:45 INFO - PID 22598 | RSS: Main: 180678656 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | __start_tp_report 10:38:45 INFO - PID 22598 | _x_x_mozilla_page_load 10:38:45 INFO - PID 22598 | _x_x_mozilla_page_load_details 10:38:45 INFO - PID 22598 | |i|pagename|runs| 10:38:45 INFO - PID 22598 | |0;ai-astar;106;110;108;107;114;116;108;108;108;111 10:38:45 INFO - PID 22598 | |1;audio-beat-detection;152;116;156;171;119;149;149;118;171;122 10:38:45 INFO - PID 22598 | |2;audio-dft;163;164;164;163;163;179;163;167;175;162 10:38:45 INFO - PID 22598 | |3;audio-fft;77;74;73;183;74;74;73;72;159;79 10:38:45 INFO - PID 22598 | |4;audio-oscillator;81;82;134;81;81;82;139;82;82;128 10:38:45 INFO - PID 22598 | |5;imaging-gaussian-blur;114;114;115;113;113;114;114;114;114;113 10:38:45 INFO - PID 22598 | |6;imaging-darkroom;151;150;150;149;148;149;148;148;148;149 10:38:45 INFO - PID 22598 | |7;imaging-desaturate;94;95;95;95;94;95;95;95;94;94 10:38:45 INFO - PID 22598 | |8;json-parse-financial;47;47;47;46;49;47;52;46;47;49 10:38:45 INFO - PID 22598 | |9;json-stringify-tinderbox;56;56;56;56;59;56;56;56;56;57 10:38:45 INFO - PID 22598 | |10;stanford-crypto-aes;81;80;79;81;79;79;82;78;112;80 10:38:45 INFO - PID 22598 | |11;stanford-crypto-ccm;125;130;123;132;129;123;121;129;122;120 10:38:45 INFO - PID 22598 | |12;stanford-crypto-pbkdf2;177;179;176;173;174;169;174;176;177;172 10:38:45 INFO - PID 22598 | |13;stanford-crypto-sha256-iterative;63;66;63;63;61;67;66;64;63;65 10:38:45 INFO - PID 22598 | __end_tp_report 10:38:45 INFO - PID 22598 | __start_cc_report 10:38:45 INFO - PID 22598 | _x_x_mozilla_cycle_collect,867 10:38:45 INFO - PID 22598 | __end_cc_report 10:38:45 INFO - PID 22598 | __startTimestamp1496943525699__endTimestamp 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | ------- Summary: start ------- 10:38:45 INFO - PID 22598 | Number of tests: 14 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#0] ai-astar Cycles:10 Average:109.60 Median:109.00 stddev:3.20 (2.9%) stddev-sans-first:3.12 10:38:45 INFO - PID 22598 | Values: 106.0 110.0 108.0 107.0 114.0 116.0 108.0 108.0 108.0 111.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:150.50 stddev:21.75 (14.4%) stddev-sans-first:22.78 10:38:45 INFO - PID 22598 | Values: 152.0 116.0 156.0 171.0 119.0 149.0 149.0 118.0 171.0 122.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#2] audio-dft Cycles:10 Average:166.30 Median:164.00 stddev:5.87 (3.6%) stddev-sans-first:6.10 10:38:45 INFO - PID 22598 | Values: 163.0 164.0 164.0 163.0 163.0 179.0 163.0 167.0 175.0 162.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#3] audio-fft Cycles:10 Average:93.80 Median:74.00 stddev:41.13 (55.6%) stddev-sans-first:43.17 10:38:45 INFO - PID 22598 | Values: 77.0 74.0 73.0 183.0 74.0 74.0 73.0 72.0 159.0 79.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:81.50 stddev:25.30 (31.0%) stddev-sans-first:26.15 10:38:45 INFO - PID 22598 | Values: 81.0 82.0 134.0 81.0 81.0 82.0 139.0 82.0 82.0 128.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 10:38:45 INFO - PID 22598 | Values: 114.0 114.0 115.0 113.0 113.0 114.0 114.0 114.0 114.0 113.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.05 (0.7%) stddev-sans-first:0.83 10:38:45 INFO - PID 22598 | Values: 151.0 150.0 150.0 149.0 148.0 149.0 148.0 148.0 148.0 149.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:38:45 INFO - PID 22598 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#8] json-parse-financial Cycles:10 Average:47.70 Median:47.00 stddev:1.83 (3.9%) stddev-sans-first:1.92 10:38:45 INFO - PID 22598 | Values: 47.0 47.0 47.0 46.0 49.0 47.0 52.0 46.0 47.0 49.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.00 stddev:0.97 (1.7%) stddev-sans-first:1.01 10:38:45 INFO - PID 22598 | Values: 56.0 56.0 56.0 56.0 59.0 56.0 56.0 56.0 56.0 57.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:80.00 stddev:10.22 (12.8%) stddev-sans-first:10.82 10:38:45 INFO - PID 22598 | Values: 81.0 80.0 79.0 81.0 79.0 79.0 82.0 78.0 112.0 80.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:127.00 stddev:4.25 (3.3%) stddev-sans-first:4.50 10:38:45 INFO - PID 22598 | Values: 125.0 130.0 123.0 132.0 129.0 123.0 121.0 129.0 122.0 120.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:176.00 stddev:2.91 (1.7%) stddev-sans-first:2.96 10:38:45 INFO - PID 22598 | Values: 177.0 179.0 176.0 173.0 174.0 169.0 174.0 176.0 177.0 172.0 10:38:45 INFO - PID 22598 | 10:38:45 INFO - PID 22598 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:1.85 (2.9%) stddev-sans-first:1.92 10:38:45 INFO - PID 22598 | Values: 63.0 66.0 63.0 63.0 61.0 67.0 66.0 64.0 63.0 65.0 10:38:45 INFO - PID 22598 | -------- Summary: end -------- 10:38:45 INFO - PID 22598 | 10:38:46 INFO - TEST-INFO | 22598: exit 0 10:38:46 INFO - TEST-OK | kraken | took 90099ms 10:38:46 INFO - SUITE-END | took 1231s 10:38:47 INFO - Completed test suite (00:20:31) 10:38:47 INFO - javascript benchmark 10:38:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8091.570948517823, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3368.0401085690582, 3408.0, 3442.60410052844, 3458.4120699481086, 3459.7232221422287, 6005.279366476024, 6029.849253768658, 6047.9999999999945, 6057.757689692418, 6083.452489275965, 6013.488853447451, 6058.636481811094, 6072.939270607292, 6087.269527656687, 6092.299385570661, 5360.65155764876, 5408.810691625794, 5409.188621706756, 5446.2375267462585, 5450.482204190595, 5444.183372494138, 5467.152591348347, 5471.124620060791, 5486.698231597261, 5494.450554944514, 5408.378036525791, 5423.105187644034, 5437.537809286196, 5470.617056806005, 5495.835124946258, 5401.918971215435, 5445.727713614304, 5483.99999999998, 5498.0, 5501.174823776446, 5366.275552800361, 5391.865203369908, 5429.728513574345, 5444.591655625804, 5447.836564903059, 6012.18835457212, 6021.277446706379, 6120.112583675342, 6125.019996800491, 6134.355892631299, 6449.83875403114, 6495.253045899687, 6528.93471065288, 6569.178852643419, 6575.3095924927675, 6532.11816404784, 6538.476921846241, 6540.93459065408, 6556.475481961479, 6573.046908198285, 6049.879002419971, 6061.727222275008, 6075.848103797441, 6106.786262480792, 6124.479419249369, 5613.7193140342815, 6601.207855057424, 6686.331366863372, 6722.327767223239, 6835.692393842289, 6485.643289619022, 6490.643014634146, 6492.5455218134275, 6494.188226471691, 6516.902246466307, 6474.773382931575, 6559.048937903977, 6597.571157874723, 6623.07276981223, 6643.667816609151, 6462.806115816533, 6463.0, 6506.056621789814, 6589.83525411859, 6601.207855057328, 5670.659760414388, 6172.876542469216, 6588.934110658832, 6601.8349541260895, 6633.900491492632, 4888.804447822118, 4912.606991440676, 4938.975305123451, 4941.234108713155, 4964.131277026506, 4336.82652693895, 4342.891427714332, 4360.847370342023, 4375.431193944767, 4378.737275763465, 6065.6663883486835, 6103.115048317969, 6131.264248290234, 6131.529590167202, 6131.724072416752, 6463.15978922737, 6508.479321654351, 6521.347865213535, 6535.738570457223, 6546.803595892131, 6038.516918646497, 6083.148359229712, 6115.449609535163, 6124.968882250436, 6140.385961403913, 5546.029444847136, 5569.749361278752, 5570.470805273492, 5572.3034620672415, 5574.414686457944, 6706.362895524917, 6766.661666916536, 6797.5921444712485, 6904.654767261617, 6923.2038315594355, 6506.837329066811, 6528.053432252392, 6529.281779004401, 6531.2489063756375, 6547.738090476328, 5328.920066199088, 6664.866702666017, 6674.733010679518, 6686.732530698912, 6719.059331693665, 6529.8694026120165, 6537.411632953057, 6555.508336874849, 6556.508261880474, 6560.803175904731, 6663.067170596218, 6695.631740254333, 6699.631520266237, 6710.731570737116, 6711.697973591103, 6342.0, 6440.484761219185, 6484.5460817742305, 6490.707918143789, 6515.0553169791065, 6398.1362516059735, 6439.259485159267, 6468.353164683682, 6476.352364763486, 6478.060681201294, 6307.779227727007, 6342.936570634419, 6396.42432181106, 6400.263969643551, 6423.0, 6509.1863517060365, 6517.348265173445, 6522.478201743944, 6527.51043671717, 6530.08578798959, 6283.37166283368, 6305.558610897193, 6315.463185629273, 6322.462590679844, 6337.746490140527], "value": 5982.174671340773, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.3495463810401, 812.1431889356726, 842.3429724814645, 856.6573370651738, 857.8756080368347, 36403.45394819076, 37277.0, 37376.0, 37440.812795935984, 37506.0, 34352.31295374097, 34448.31103377931, 34582.481262781075, 34723.30553388931, 34744.30511389771, 6292.370762923717, 6405.263394709598, 6405.647689377082, 6408.10286559882, 6412.935870641304, 6222.439980401763, 6275.435210831024, 6298.181236439256, 6302.747890084391, 6315.90526142106, 6243.906341404882, 6247.812565623039, 6260.060990851363, 6272.686365681698, 6297.023961286008, 6230.968845155768, 6264.937350626504, 6267.6866156691985, 6271.435570798627, 6280.811575652738, 5841.4450627190345, 5904.321003084658, 5909.645421274694, 6568.704408301638, 7081.575105493687, 35215.1196220094, 35431.82284088563, 35440.822795885855, 35531.644683553095, 35572.28855422877, 3465.4455287153933, 3496.125968507873, 3532.346515894568, 3533.487644291589, 3534.0988048047584, 27564.586531202047, 27792.444151117066, 27929.86035069832, 27957.440851183066, 28002.299942501395, 3204.070819462353, 3290.2596915694016, 3291.53918451417, 3307.074019274607, 3317.5853018372704, 174525.0, 175488.0, 176526.99999999872, 202941.0, 204736.0, 39994.80002600027, 42625.78687106607, 43693.0, 45658.31512527315, 45916.39292624742, 47785.0, 47826.5217347822, 47837.043259134625, 47838.76080619644, 47885.28172077422, 15174.165420901956, 15225.923870380577, 15232.0, 15242.542723718307, 15297.9235103826, 12384.690382740504, 12408.317542535247, 12422.937885310515, 12424.440900159514, 12427.130100892851, 13772.931135344259, 13818.585442436743, 13901.79147312791, 13989.3704783285, 14093.78859317111, 5604.663720176803, 5645.689487078168, 5729.0, 5817.243758311477, 5847.795327163529, 1046.942418167008, 1053.8155822730992, 1057.259918057363, 1066.4987455895716, 1070.314998401024, 23451.648225276633, 23451.88274058619, 23852.64221036686, 24330.635040474408, 24550.386240343778, 1103.9779204416027, 1119.587289391363, 1149.2127892393737, 1175.723704929341, 1177.8468799056238, 12565.371731413392, 13041.804372934414, 13042.347882606022, 13138.277394743382, 13166.539171128965, 255946.0, 256338.0, 256979.0, 257233.0, 257722.0, 48843.0, 49170.0, 49358.25962610564, 49376.0, 49435.258471122965, 1410.5133728863525, 1499.182945294817, 1506.058713304185, 1511.2443778110944, 1514.2882845062802, 23558.528829422972, 23708.88145559261, 23720.288391348287, 23734.762652373254, 24105.517889641756, 35854.64145358618, 36143.0, 36209.63790362063, 36224.818875905454, 36280.45579316365, 216610.0, 217145.0, 217566.0, 217871.0, 218465.0, 30386.84806575953, 32003.35993280168, 32216.516752248266, 32422.513662294612, 32577.837110815242, 37625.0, 39758.2048359037, 40544.391834121925, 40578.0, 40620.1875962485, 28411.0, 29477.0, 30317.69682303149, 30909.845450772602, 31444.056678299687, 29972.85013574918, 30455.543166852956, 31389.52915706312, 31484.0, 32136.696048163296, 35857.82071089628, 36545.634543654225, 37235.0, 37253.25493490169, 37365.065873353386, 29044.27389315284, 29288.121356359345, 30123.849380753833, 30567.23581910381, 31119.377612448076, 24790.38024049413, 25044.74955250497, 25550.616740748534, 25551.361215969748, 25715.485690286463], "value": 16149.15066022244, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.2381116419788, 520.0768635671682, 520.3157847430629, 529.5287194396986, 539.2908325551897, 19756.407307780755, 19844.90077549614, 20058.799412005876, 20746.688799668016, 20775.16899324027, 22170.778292217074, 22654.88672556639, 22778.65832012521, 22786.2024829131, 22835.429114272152, 5568.1091025435935, 5719.628224165437, 5755.079187330028, 5756.798512052079, 5763.279590051244, 5544.0575102232715, 5601.047821870271, 5606.327240731098, 5626.381098079208, 5630.09918413054, 5159.793608255665, 5557.055300598888, 5566.0, 5585.944140558583, 5632.859178520529, 5579.414161513044, 5598.804041858536, 5606.607537472379, 5614.803481878114, 5636.91544626833, 5219.112750832368, 5226.817061402832, 5226.92159617606, 5237.764300606444, 5257.789688412459, 25243.242702718948, 25562.23313300604, 25596.48807023849, 25601.10396136145, 25776.48447031049, 2111.271611294101, 2200.614892393841, 2202.977970220293, 2204.2285200179967, 2227.6992605998144, 17434.564135896577, 17651.117444127744, 17744.290228390848, 17774.55563610907, 17782.0, 2191.2659259148045, 2207.834412419075, 2220.222921977311, 2247.2808701215617, 2281.771822817705, 107547.46226268896, 113340.4332978338, 113713.0, 119725.40137299345, 129658.40683186284, 13429.39567719455, 13503.852172565443, 13730.794038089436, 14151.858481415054, 14434.206118663575, 20370.083346249456, 20382.592348152953, 20419.8979005107, 20428.0, 20441.591168176554, 9289.767755806159, 9445.952770236105, 9550.323125596557, 9575.856362154573, 9643.373180743229, 8627.48235105883, 8673.176048275403, 8738.563071846509, 8824.426412283181, 8864.246539044125, 8548.658053677907, 8617.138286171457, 8711.34664900135, 8719.60761765722, 8765.649374025095, 2543.300592337122, 2553.553128202557, 2565.4869026194838, 2579.8839052242693, 2620.3318153871023, 1005.1556692378438, 1014.8442129479769, 1019.9031092046243, 1035.6582327831798, 1076.3810808784824, 19232.423027309203, 19838.305659301855, 19906.50233744168, 19987.60024799496, 20210.79789202089, 1035.404642330663, 1043.1602559939322, 1057.545255540125, 1069.9625513107003, 1071.3571856885962, 10603.257771955889, 10693.395990601472, 10720.517576709066, 10850.837237441445, 10868.184886133571, 481192.0, 484871.0, 491339.0, 493866.0, 496774.0, 106669.46665266623, 107663.0, 108995.0, 110135.0, 110273.44863275792, 1187.228301603947, 1188.233589334874, 1212.2665787198794, 1223.1132428988913, 1230.852297724261, 17086.91456542759, 17146.0, 17572.0, 19059.0, 20597.0, 48772.0, 52431.737841312075, 53577.732111339195, 53967.73016134894, 55241.44758552524, 63864.0, 64335.678321608095, 64406.67796660987, 64583.67708161429, 64605.0, 11650.242734222249, 11675.591354302558, 11757.882421175678, 11761.764764704487, 11783.52865885355, 17103.657926841144, 18083.909580452015, 18124.27502899869, 18383.0, 18385.90807045956, 12325.322107284186, 12844.0, 13011.544595939096, 13068.934655326662, 13230.206187628773, 12766.936165319114, 13471.663208419868, 13798.862011379757, 13995.650108747363, 14027.859721403063, 12908.935455322664, 13641.249731264876, 14467.92766036163, 14649.92675036618, 14779.408823646934, 11045.889541104487, 11070.612528561784, 11182.32906025641, 11214.102871770076, 11229.27009744364, 13671.316434178052, 13680.179189248676, 13719.45122195101, 13759.931200343934, 13762.931185344009], "value": 10725.39612525294, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.2500299844082, 1503.759398496241, 1507.0957425544675, 1516.8179818421784, 1529.8623123918849, 13117.278549679764, 13656.658583535393, 13667.589972300822, 13696.657583560416, 13725.450981960723, 11347.489362978666, 11693.883061169387, 11779.70550736232, 11790.115741319392, 11806.114541409408, 2452.2030340139436, 2538.860362680052, 2576.046862660818, 2576.7809736172353, 2582.6642536470326, 2557.514072326261, 2593.688757349121, 2598.1296265751, 2603.3491627093226, 2603.986980065097, 2382.797462215714, 2431.9756802431925, 2443.609022556391, 2448.2165706973774, 2450.473148273121, 2269.693591365161, 2276.578832915916, 2281.9885900570475, 2288.6452599846966, 2321.6285394336824, 2305.054927479742, 2333.3233362324904, 2352.0591763294647, 2354.0, 2362.8582285062953, 13179.209247445087, 13206.73586528264, 13279.73440531184, 13316.800247996287, 13328.933355333258, 7173.390261827751, 7410.925890741078, 7423.480356375056, 7423.888641670379, 7450.739224127184, 4104.507459104897, 4281.828726850922, 4346.630536404409, 4378.956210437918, 4424.491183513873, 1438.6906815034713, 1472.0505274098148, 1476.616079819244, 1477.8300495443054, 1493.6415260337549, 21778.128874845144, 21790.346289611178, 21905.671414928787, 21938.0, 21946.780532194793, 6453.903191452132, 6566.5403421760975, 6610.933890661032, 6779.72881084751, 6830.863382732317, 17449.21478533469, 17493.82506174922, 17505.649887002444, 17511.299548018193, 17572.82427175712, 7484.850302993909, 7567.848643027109, 7577.204393538599, 7578.317951384402, 7598.962005189938, 6633.170853643294, 6698.698558564876, 6768.898466523006, 6913.481488888354, 7023.473239507058, 4685.0, 4773.140834649727, 4910.48439913811, 5214.9478505214465, 5349.251104845324, 1555.4866893924977, 1564.1475395909256, 1570.6780110077407, 1572.709048825971, 1603.5590212691602, 924.177482040984, 924.8381533231658, 937.1471960515897, 955.3790036476346, 973.1047436358567, 7991.200879912079, 8339.291160251447, 8911.465312081296, 8984.910150898539, 8990.595423205972, 714.1002337055347, 734.0823970037453, 741.2994719989558, 745.571296504512, 1005.8491226315965, 4634.83778067766, 4945.357103576512, 5027.195648696191, 5096.51583099605, 5141.408737995103, 17883.910580447013, 18109.36617218391, 18700.438986830417, 18704.345347912757, 18711.251549938122, 17926.91036544809, 18073.909630451762, 18191.818081819278, 18324.083795810155, 18332.54168645768, 10215.846762298572, 10424.68725938223, 10469.0, 10663.306885052447, 10784.191185661106, 8038.155993620586, 8062.355011599176, 8281.0, 8324.209200125979, 8586.239820836588, 15353.0, 15780.763288550452, 16096.597585059999, 16454.917725411295, 16503.422380216634, 15187.840150052592, 16332.101734404721, 16361.427350042692, 16471.094089825176, 16536.338546458006, 12342.382880855741, 12688.936555317534, 12812.423440945366, 12965.935170324465, 12990.285534295326, 11474.770504589695, 11790.823137652771, 11825.290482570728, 11838.467268972745, 12942.676433089247, 9390.530473476163, 9605.567749451431, 9685.757856053655, 10137.493125343852, 10481.161507079567, 10003.849942250727, 10165.390076595428, 10322.638707645498, 10346.37921724699, 10519.421431821018, 8998.64005439775, 9012.32407569448, 9074.137956894085, 9116.08839116083, 9201.0, 6751.594904305757, 6964.721411143701, 7031.718731250693, 7188.928110718826, 7381.741639042608, 7156.141263048467, 7378.778636640909, 7447.664855081643, 7487.138979017265, 7668.233176682287], "value": 6136.555026981918, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.54045954045955, 472.2703423211141, 486.25845585482136, 491.518312054187, 492.94577596464404, 6202.813915582534, 6282.732978851001, 6286.8113956581265, 6289.559730818844, 6336.873262534747, 5907.970460147704, 6013.609115407496, 6054.848628784272, 6080.483158931496, 6115.908261376083, 4864.0, 4968.006398720252, 4984.925226121611, 5001.774920128585, 5041.193409054552, 4974.850754477371, 4977.47736487669, 4984.102861484931, 4988.2766998785155, 4992.700437973715, 4920.507949205086, 4938.48145944676, 4951.356323677916, 4993.425756038047, 4996.375453068366, 4949.331840201563, 4949.480304568005, 4955.058538877602, 4961.412348048626, 4963.2058870580895, 4356.172327257811, 4419.315006174048, 4450.1767173073085, 4493.236149854532, 4509.819607215707, 6060.727267272983, 6061.848453788646, 6083.178770865965, 6093.756249750049, 6094.238220222473, 5937.406259374028, 5938.079597662369, 5957.463828255434, 5968.4031596840405, 5988.251468566429, 6624.205095388585, 6634.800955971328, 6637.601743895333, 6682.933170668328, 6685.93314066858, 5095.0, 5108.259302401131, 5139.357580302462, 5143.074246635604, 5166.870828229286, 6878.896816547755, 6880.65596720162, 6895.586264824126, 6898.965505172492, 6908.620025898574, 5298.2052692096495, 5313.468653134656, 5316.0962636351915, 5327.706976116351, 5332.253484512172, 5382.1119515280325, 5382.407935127133, 5390.733177703237, 5396.757145928443, 5411.918821217685, 5910.556708246899, 5915.142304365843, 5917.674527900921, 5921.940780592225, 5954.432605513858, 6658.833529161713, 6659.766908158192, 6661.16735408074, 6672.7330906764155, 6680.5991640501725, 1875.7467741854948, 1898.250191174506, 1899.886006839594, 1899.9265415040459, 1902.1345287893976, 1158.8609366876028, 1223.113242898909, 1226.9938650306692, 1227.1348699167065, 1233.309346765814, 5873.3245676746865, 6216.270237857249, 6246.75012999484, 6283.340249273851, 6289.465395441347, 6764.797056088325, 6787.490938179656, 6788.355106264897, 6806.081179040865, 6806.897896531556, 6048.455638992512, 6051.515878729691, 6091.878162436727, 6128.417800308964, 6141.324454310023, 3530.0821786335737, 3537.3809583322814, 3564.6078931317534, 3584.408572585546, 3604.621514740967, 6909.481788865754, 6992.0, 7001.369876711018, 7019.578825270398, 7022.789316320519, 6849.089137116705, 6895.931040689629, 6904.171499420102, 6910.2053263874295, 6945.0, 6836.487263455261, 6905.792826215121, 6941.965290173517, 6973.302669732986, 6982.720691172398, 6664.233613134357, 6700.128983232149, 6730.192376914802, 6730.192376914802, 6733.293004234485, 6710.396064354231, 6724.394804467622, 6736.675846832834, 6738.079647300496, 6744.022116793136, 6940.791776246519, 6977.406920411619, 6987.650617469005, 6996.965015174892, 7013.509054366349, 4938.2839488273285, 4952.257161425671, 4956.231784073474, 4978.7510624467905, 4984.651074424755, 6383.755167742245, 6746.426553742791, 6804.96597517029, 6814.727410903508, 6850.691718872762, 6237.4698150657705, 6578.835529111619, 6587.604743715392, 6588.903215488713, 6599.67001649906, 6569.80290591283, 6593.011048342787, 6630.403263706289, 6635.942857714124, 6642.376261376826, 6488.805335839932, 6500.187476565429, 6517.7067031984625, 6520.510961677798, 6543.70553325111, 6554.344565543408, 6559.704813283318, 6586.4401525870835, 6591.802245932629, 6600.438962688033, 6343.492520598434, 6398.488120950406, 6429.7428102875365, 6442.484601231984, 6462.095306657166], "value": 5148.218385833218, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.1893544326564, 860.2172023458658, 867.7049803066956, 870.4429165334187, 873.0178549132227, 17043.233054512544, 17280.22238999245, 17436.476905692816, 17715.291388344453, 17744.46766597001, 12933.094683372168, 13298.335083245847, 13767.0, 14700.852991470083, 14724.19016954067, 743.423846518948, 907.63694522191, 912.9132732390445, 1015.1726343030407, 1016.6797458800454, 1006.6225165562914, 1014.9492525373739, 1015.3095894791538, 1015.725754046407, 1017.1455976979336, 1062.984055239172, 1064.9946750266276, 1069.8127827630133, 1069.9732506687355, 1070.7055559721061, 1057.106744800646, 1062.6227689170387, 1063.3619828103153, 1063.4416931111114, 1065.3128731967838, 549.5356423821864, 561.9662820230799, 564.7712676366078, 778.5951305321202, 779.672537534237, 13228.140170888957, 16316.918415407847, 16947.40684076064, 16964.151792410332, 17071.914640426843, 17987.910060449743, 18069.864416090317, 19238.422847314603, 19428.90285548563, 19447.124879380463, 12545.247285162919, 12673.746525069539, 12729.490820367268, 12914.612561623073, 12931.870681293254, 3331.716804071657, 3355.0773537277446, 3385.7460690448315, 3386.0349800306794, 3387.0177648481913, 73258.63370683113, 102809.80917913321, 104746.47626761894, 104905.0, 106964.46517767438, 12411.62765117048, 12621.432035558422, 14147.504837330644, 14724.411023559152, 14858.182799946107, 26583.601245981325, 27064.0, 27520.724792751815, 27747.028853990014, 27798.305042373697, 8032.236937490929, 8163.224493673091, 8196.385271104691, 8203.220694034057, 8236.752897413087, 3919.510061242345, 3996.8401263949117, 4036.334004889219, 4037.4953130858644, 4041.1715598302276, 4647.209974304376, 4686.906261874743, 4796.424429068534, 4803.759812009385, 4908.852734417973, 968.9660861869942, 987.1017374189453, 1004.2919741582167, 1004.4626125023077, 1006.436395618456, 654.0646874968745, 661.3750006244053, 661.9139511863523, 670.165643773505, 682.0825989044727, 11637.522095612983, 12135.393230338448, 12416.875831241572, 12487.625371238877, 13563.932180339232, 723.8479919217024, 730.3353947907378, 730.831908661011, 734.8346622010112, 747.4468893019126, 5559.77760889568, 5796.94203057964, 5871.089981052944, 6026.276846778414, 6076.574639775174, 102373.0, 102932.0, 106532.0, 106997.0, 107769.0, 88090.55954720314, 90109.0, 90204.09795902089, 92065.0, 94561.0, 71475.6426217876, 78295.0, 80379.0, 81727.5913620428, 82048.58975705084, 12020.098492613264, 12317.260964342167, 12377.319247441477, 12599.0, 12714.427850746924, 31595.684043159275, 39142.80428597839, 39200.411993820686, 39477.802610987914, 41100.58899411087, 61904.38095618986, 61992.380076198664, 62909.37090629035, 66819.0, 68123.0, 18033.639327213645, 18203.726944096114, 18408.723869142243, 18601.53496162607, 18778.812211877706, 18130.546736331697, 19037.333693320666, 19142.425727228205, 19370.0, 19665.311714089938, 19427.0, 19449.222031118596, 19701.310454134036, 19752.209911603375, 19810.40568782939, 18098.185581648595, 18466.722999154754, 18679.439616811516, 18732.344367947055, 18990.050497475346, 18106.72839907376, 18419.171137299123, 19133.712994305373, 19304.806951930863, 19332.90333548323, 13039.608811735663, 13441.059125861097, 13645.454181832616, 13898.722025559635, 14278.714425711636, 13200.867991319963, 13308.407887123152, 13573.321333933462, 13632.591022269347, 13770.727829907953], "value": 8573.726808132129, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 110.0, 108.0, 107.0, 114.0, 116.0, 108.0, 108.0, 108.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 116.0, 156.0, 171.0, 119.0, 149.0, 149.0, 118.0, 171.0, 122.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 163.0, 163.0, 179.0, 163.0, 167.0, 175.0, 162.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 73.0, 183.0, 74.0, 74.0, 73.0, 72.0, 159.0, 79.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 134.0, 81.0, 81.0, 82.0, 139.0, 82.0, 82.0, 128.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 149.0, 148.0, 149.0, 148.0, 148.0, 148.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 47.0, 46.0, 49.0, 47.0, 52.0, 46.0, 47.0, 49.0], "value": 47.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 59.0, 56.0, 56.0, 56.0, 56.0, 57.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 81.0, 79.0, 79.0, 82.0, 78.0, 112.0, 80.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 130.0, 123.0, 132.0, 129.0, 123.0, 121.0, 129.0, 122.0, 120.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 179.0, 176.0, 173.0, 174.0, 169.0, 174.0, 176.0, 177.0, 172.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 63.0, 61.0, 67.0, 66.0, 64.0, 63.0, 65.0], "value": 64.1, "unit": "score"}]}]} 10:38:47 INFO - Return code: 0 10:38:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:38:47 INFO - # TBPL SUCCESS # 10:38:47 INFO - Running post-action listener: _resource_record_post_action 10:38:47 INFO - [mozharness: 2017-06-08 17:38:47.574683Z] Finished run-tests step (success) 10:38:47 INFO - Running post-run listener: _resource_record_post_run 10:38:47 INFO - Total resource usage - Wall time: 1249s; CPU: 13.0%; Read bytes: 0; Write bytes: 423251968; Read time: 0; Write time: 296288 10:38:47 INFO - TinderboxPrint: CPU usage
12.6% 10:38:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:38:47 INFO - TinderboxPrint: I/O write bytes / time
423,251,968 / 296,288 10:38:47 INFO - TinderboxPrint: CPU idle
8,715.0 (87.4%) 10:38:47 INFO - TinderboxPrint: CPU user
1,200.5 (12.0%) 10:38:47 INFO - TinderboxPrint: Swap in / out
0 / 0 10:38:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 103485440; Read time: 0; Write time: 95768 10:38:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:38:47 INFO - run-tests - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 319766528; Read time: 0; Write time: 200520 10:38:48 INFO - Running post-run listener: _upload_blobber_files 10:38:48 INFO - Blob upload gear active. 10:38:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:38:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:38:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:38:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:38:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:38:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:38:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:51 INFO - (blobuploader) - INFO - Done attempting. 10:38:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:38:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:52 INFO - (blobuploader) - INFO - Done attempting. 10:38:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:38:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:38:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:53 INFO - (blobuploader) - INFO - Done attempting. 10:38:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:38:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:38:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:54 INFO - (blobuploader) - INFO - Done attempting. 10:38:54 INFO - (blobuploader) - INFO - Iteration through files over. 10:38:54 INFO - Return code: 0 10:38:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:38:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:38:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12e4c754284a3c77c8779268b6d765ca1a1ff65eff35b8349399f78cc419e1502e46d60badcb6ca63f5aa2ce1d9c69f1851b9923c193bffab68ccc63ccb50dbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee3a2c6d49141b0b3ffba097ea656305da90c0e73164b7210f05d65f2e2237d61018672e75afacb2c790384d9c55e8c35cbc47e887a18f4b5c1d281ed426393a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a937df023af9db61415c2507c78e3a07a1c6ba0699011bf0c18d968dba3f7a222b8e55327e3d653c1c1c10e7fe2487a1b9378f1563df4e7bcb54287b3f8b11b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30becb7c9b5607971c1abb0c75617bfe87daa06bf99b8a5ddc5e5c14e8eac509d0391320205ce4f8763ba8426a37826bb8871865568709cf76d638a220ed1add"} 10:38:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:38:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:38:54 INFO - Contents: 10:38:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12e4c754284a3c77c8779268b6d765ca1a1ff65eff35b8349399f78cc419e1502e46d60badcb6ca63f5aa2ce1d9c69f1851b9923c193bffab68ccc63ccb50dbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee3a2c6d49141b0b3ffba097ea656305da90c0e73164b7210f05d65f2e2237d61018672e75afacb2c790384d9c55e8c35cbc47e887a18f4b5c1d281ed426393a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a937df023af9db61415c2507c78e3a07a1c6ba0699011bf0c18d968dba3f7a222b8e55327e3d653c1c1c10e7fe2487a1b9378f1563df4e7bcb54287b3f8b11b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30becb7c9b5607971c1abb0c75617bfe87daa06bf99b8a5ddc5e5c14e8eac509d0391320205ce4f8763ba8426a37826bb8871865568709cf76d638a220ed1add"} 10:38:54 INFO - Running post-run listener: copy_logs_to_upload_dir 10:38:54 INFO - Copying logs to upload dir... 10:38:54 INFO - mkdir: /builds/slave/test/build/upload/logs 10:38:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1306.235858 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2017-06-08 10:38:54.057003) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-08 10:38:54.061559) ========= 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=51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320 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/12e4c754284a3c77c8779268b6d765ca1a1ff65eff35b8349399f78cc419e1502e46d60badcb6ca63f5aa2ce1d9c69f1851b9923c193bffab68ccc63ccb50dbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee3a2c6d49141b0b3ffba097ea656305da90c0e73164b7210f05d65f2e2237d61018672e75afacb2c790384d9c55e8c35cbc47e887a18f4b5c1d281ed426393a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a937df023af9db61415c2507c78e3a07a1c6ba0699011bf0c18d968dba3f7a222b8e55327e3d653c1c1c10e7fe2487a1b9378f1563df4e7bcb54287b3f8b11b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30becb7c9b5607971c1abb0c75617bfe87daa06bf99b8a5ddc5e5c14e8eac509d0391320205ce4f8763ba8426a37826bb8871865568709cf76d638a220ed1add"} build_url:https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011210 build_url: 'https://queue.taskcluster.net/v1/task/KZS2N_p7TtCtogQghTyqYw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12e4c754284a3c77c8779268b6d765ca1a1ff65eff35b8349399f78cc419e1502e46d60badcb6ca63f5aa2ce1d9c69f1851b9923c193bffab68ccc63ccb50dbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee3a2c6d49141b0b3ffba097ea656305da90c0e73164b7210f05d65f2e2237d61018672e75afacb2c790384d9c55e8c35cbc47e887a18f4b5c1d281ed426393a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a937df023af9db61415c2507c78e3a07a1c6ba0699011bf0c18d968dba3f7a222b8e55327e3d653c1c1c10e7fe2487a1b9378f1563df4e7bcb54287b3f8b11b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30becb7c9b5607971c1abb0c75617bfe87daa06bf99b8a5ddc5e5c14e8eac509d0391320205ce4f8763ba8426a37826bb8871865568709cf76d638a220ed1add"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-08 10:38:54.086709) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 10:38:54.086994) ========= 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=51fc86400edbde9650d2781a000001d0-1496938859.781740-1165133320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004810 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 10:38:54.168825) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-08 10:38:54.172141) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-08 10:38:54.172442) ========= ========= Total master_lag: 0.21 =========