builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-084 starttime: 1495765448.3 results: success (0) revision: 862e534ade6d17176b09aeeb5dae63fdb53eddeb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.303031) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.303460) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.303743) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.333267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.333539) ========= 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=ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 19:24:08-- 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% 55.0M=0s 2017-05-25 19:24:08 (55.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.234812 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.584335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.584641) ========= 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=ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018999 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.636415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:08.639767) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 862e534ade6d17176b09aeeb5dae63fdb53eddeb --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 862e534ade6d17176b09aeeb5dae63fdb53eddeb --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=ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 19:24:08,654 truncating revision to first 12 chars 2017-05-25 19:24:08,654 Setting DEBUG logging. 2017-05-25 19:24:08,654 attempt 1/10 2017-05-25 19:24:08,654 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/862e534ade6d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 19:24:09,280 unpacking tar archive at: mozilla-central-862e534ade6d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.981109 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:09.635886) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:09.636186) ========= script_repo_revision: 862e534ade6d17176b09aeeb5dae63fdb53eddeb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:09.636552) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:09.636825) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 19:24:09.646353) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-25 19:24:09.646679) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:24:09 INFO - MultiFileLogger online at 20170525 19:24:09 in /builds/slave/test 19:24:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:24:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:24:09 INFO - {'append_to_log': False, 19:24:09 INFO - 'base_work_dir': '/builds/slave/test', 19:24:09 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:24:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:24:09 INFO - 'branch': 'Firefox-Non-PGO', 19:24:09 INFO - 'buildbot_json_path': 'buildprops.json', 19:24:09 INFO - 'config_files': ('talos/linux_config.py',), 19:24:09 INFO - 'default_actions': ('clobber', 19:24:09 INFO - 'read-buildbot-config', 19:24:09 INFO - 'download-and-extract', 19:24:09 INFO - 'populate-webroot', 19:24:09 INFO - 'create-virtualenv', 19:24:09 INFO - 'install', 19:24:09 INFO - 'run-tests'), 19:24:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:24:09 INFO - 'download_minidump_stackwalk': True, 19:24:09 INFO - 'download_symbols': 'ondemand', 19:24:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:24:09 INFO - 'tooltool.py': '/tools/tooltool.py', 19:24:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:24:09 INFO - '/tools/misc-python/virtualenv.py')}, 19:24:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:24:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:24:09 INFO - 'gecko_profile': False, 19:24:09 INFO - 'gecko_profile_interval': 0, 19:24:09 INFO - 'installer_path': 'installer.exe', 19:24:09 INFO - 'log_level': 'info', 19:24:09 INFO - 'log_name': 'talos', 19:24:09 INFO - 'log_to_console': True, 19:24:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:24:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:24:09 INFO - 'opt_config_files': (), 19:24:09 INFO - 'pip_index': False, 19:24:09 INFO - 'suite': 'dromaeojs-e10s', 19:24:09 INFO - 'system_bits': '32', 19:24:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:24:09 INFO - 'title': 'talos-linux64-ix-084', 19:24:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:24:09 INFO - 'use_talos_json': True, 19:24:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:24:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:24:09 INFO - 'work_dir': 'build'} 19:24:09 INFO - [mozharness: 2017-05-26 02:24:09.874975Z] Running clobber step. 19:24:09 INFO - Running pre-action listener: _resource_record_pre_action 19:24:09 INFO - Running main action method: clobber 19:24:09 INFO - rmtree: /builds/slave/test/build 19:24:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:24:10 INFO - Running post-action listener: _resource_record_post_action 19:24:10 INFO - [mozharness: 2017-05-26 02:24:10.858116Z] Finished clobber step (success) 19:24:10 INFO - [mozharness: 2017-05-26 02:24:10.858216Z] Running read-buildbot-config step. 19:24:10 INFO - Running pre-action listener: _resource_record_pre_action 19:24:10 INFO - Running main action method: read_buildbot_config 19:24:10 INFO - Using buildbot properties: 19:24:10 INFO - { 19:24:10 INFO - "project": "", 19:24:10 INFO - "product": "firefox", 19:24:10 INFO - "who": "ryanvm@gmail.com", 19:24:10 INFO - "installer_path": "public/build/target.tar.bz2", 19:24:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:24:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:24:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:24:10 INFO - "stage_platform": "linux64", 19:24:10 INFO - "basedir": "/builds/slave/test", 19:24:10 INFO - "buildnumber": 853, 19:24:10 INFO - "platform": "ubuntu64_hw", 19:24:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:24:10 INFO - "slavebuilddir": "test", 19:24:10 INFO - "taskId": "GEJQ-9cfT0GpjvurHnVcsw", 19:24:10 INFO - "branch": "mozilla-central", 19:24:10 INFO - "script_repo_revision": "production", 19:24:10 INFO - "revision": "862e534ade6d17176b09aeeb5dae63fdb53eddeb", 19:24:10 INFO - "slavename": "talos-linux64-ix-084", 19:24:10 INFO - "repo_path": "mozilla-central" 19:24:10 INFO - } 19:24:10 INFO - Finding installer, test and symbols from parent task. 19:24:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GEJQ-9cfT0GpjvurHnVcsw'}, attempt #1 19:24:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GEJQ-9cfT0GpjvurHnVcsw'}, attempt #1 19:24:11 INFO - Task dependencies: FHEJyh-hTU2GpJXElrX5FQ 19:24:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ'}, attempt #1 19:24:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.tar.bz2 19:24:12 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/test_packages.json 19:24:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.crashreporter-symbols.zip 19:24:12 INFO - Running post-action listener: _resource_record_post_action 19:24:12 INFO - [mozharness: 2017-05-26 02:24:12.214568Z] Finished read-buildbot-config step (success) 19:24:12 INFO - [mozharness: 2017-05-26 02:24:12.214786Z] Running download-and-extract step. 19:24:12 INFO - Running pre-action listener: _resource_record_pre_action 19:24:12 INFO - Running main action method: download_and_extract 19:24:12 INFO - mkdir: /builds/slave/test/build/tests 19:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:12 INFO - trying https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.test_packages.json 19:24:12 INFO - Downloading https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:24:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:24:12 INFO - Downloaded 986 bytes. 19:24:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:24:12 INFO - Using the following test package requirements: 19:24:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:24:12 INFO - u'common': [u'target.common.tests.zip'], 19:24:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:24:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:24:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:24:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:24:12 INFO - u'mozbase': [u'target.common.tests.zip'], 19:24:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:24:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:24:12 INFO - u'web-platform': [u'target.common.tests.zip', 19:24:12 INFO - u'target.web-platform.tests.zip'], 19:24:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:24:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:24:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.common.tests.zip 19:24:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:24:12 INFO - Fetch https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.common.tests.zip into memory 19:24:14 INFO - Content-Length response header: 63525231 19:24:14 INFO - Bytes received: 63525231 19:24:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:24:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.common.tests.zip 19:24:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:24:25 INFO - Fetch https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.common.tests.zip into memory 19:24:26 INFO - Content-Length response header: 63525231 19:24:26 INFO - Bytes received: 63525231 19:24:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.talos.tests.zip 19:24:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:24:39 INFO - Fetch https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.talos.tests.zip into memory 19:24:40 INFO - Content-Length response header: 14411888 19:24:40 INFO - Bytes received: 14411888 19:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:40 INFO - trying https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.tar.bz2 19:24:40 INFO - Downloading https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:24:41 INFO - Downloaded 54191200 bytes. 19:24:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.tar.bz2 19:24:41 INFO - mkdir: /builds/slave/test/properties 19:24:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:24:41 INFO - Writing to file /builds/slave/test/properties/build_url 19:24:41 INFO - Contents: 19:24:41 INFO - build_url:https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.tar.bz2 19:24:41 INFO - Running post-action listener: _resource_record_post_action 19:24:41 INFO - Running post-action listener: set_extra_try_arguments 19:24:41 INFO - [mozharness: 2017-05-26 02:24:41.676717Z] Finished download-and-extract step (success) 19:24:41 INFO - [mozharness: 2017-05-26 02:24:41.676947Z] Running populate-webroot step. 19:24:41 INFO - Running pre-action listener: _resource_record_pre_action 19:24:41 INFO - Running main action method: populate_webroot 19:24:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:24:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:24:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:24:41 INFO - '--tppagecycles', 19:24:41 INFO - '7'], 19:24:41 INFO - 'tests': ['tsvgm']}}, 19:24:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:24:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:24:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:24:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:24:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:24:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:24:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:24:41 INFO - 'talos_options': ['--disable-e10s'], 19:24:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:24:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:24:41 INFO - 'talos_options': ['--disable-e10s'], 19:24:41 INFO - 'tests': ['damp', 'tps']}, 19:24:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:24:41 INFO - 'tests': ['damp', 'tps']}, 19:24:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:24:41 INFO - 'tests': ['dromaeo_dom']}, 19:24:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:24:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:24:41 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:24:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:24:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:24:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:24:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:24:41 INFO - 'tests': ['a11yr', 19:24:41 INFO - 'ts_paint', 19:24:41 INFO - 'tpaint', 19:24:41 INFO - 'sessionrestore', 19:24:41 INFO - 'sessionrestore_no_auto_restore', 19:24:41 INFO - 'tabpaint']}, 19:24:41 INFO - 'other-e10s': {'tests': ['a11yr', 19:24:41 INFO - 'ts_paint', 19:24:41 INFO - 'tpaint', 19:24:41 INFO - 'sessionrestore', 19:24:41 INFO - 'sessionrestore_no_auto_restore', 19:24:41 INFO - 'tabpaint']}, 19:24:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:24:41 INFO - 'ts_paint', 19:24:41 INFO - 'tpaint', 19:24:41 INFO - 'sessionrestore', 19:24:41 INFO - 'sessionrestore_no_auto_restore', 19:24:41 INFO - 'tabpaint']}, 19:24:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:24:41 INFO - 'ts_paint', 19:24:41 INFO - 'tpaint', 19:24:41 INFO - 'sessionrestore', 19:24:41 INFO - 'sessionrestore_no_auto_restore', 19:24:41 INFO - 'tabpaint']}, 19:24:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:24:41 INFO - 'tests': ['a11yr', 19:24:41 INFO - 'ts_paint', 19:24:41 INFO - 'tpaint', 19:24:41 INFO - 'sessionrestore', 19:24:41 INFO - 'sessionrestore_no_auto_restore', 19:24:41 INFO - 'tabpaint']}, 19:24:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:24:41 INFO - 'tests': ['a11yr', 19:24:41 INFO - 'ts_paint', 19:24:41 INFO - 'tpaint', 19:24:41 INFO - 'sessionrestore', 19:24:41 INFO - 'sessionrestore_no_auto_restore', 19:24:41 INFO - 'tabpaint']}, 19:24:41 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 19:24:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 19:24:41 INFO - 'bloom_basic_ref']}, 19:24:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:24:41 INFO - 'tests': ['tsvgx', 19:24:41 INFO - 'tsvgr_opacity', 19:24:41 INFO - 'tart', 19:24:41 INFO - 'tscrollx', 19:24:41 INFO - 'cart', 19:24:41 INFO - 'tsvg_static']}, 19:24:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:24:41 INFO - 'tsvgr_opacity', 19:24:41 INFO - 'tart', 19:24:41 INFO - 'tscrollx', 19:24:41 INFO - 'cart', 19:24:41 INFO - 'tsvg_static']}, 19:24:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:24:41 INFO - 'talos_options': ['--disable-e10s'], 19:24:41 INFO - 'tests': ['tp5o']}, 19:24:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:24:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:24:41 INFO - 'talos_options': ['--disable-e10s', 19:24:41 INFO - '--xperf_path', 19:24:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:41 INFO - 'tests': ['tp5n']}, 19:24:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:24:41 INFO - 'talos_options': ['--xperf_path', 19:24:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:41 INFO - 'tests': ['tp5n']}}, 19:24:41 INFO - 'talos.zip': {'path': '', 19:24:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:24:41 INFO - Running post-action listener: _resource_record_post_action 19:24:41 INFO - [mozharness: 2017-05-26 02:24:41.700944Z] Finished populate-webroot step (success) 19:24:41 INFO - [mozharness: 2017-05-26 02:24:41.701092Z] Running create-virtualenv step. 19:24:41 INFO - Running pre-action listener: _resource_record_pre_action 19:24:41 INFO - Running main action method: create_virtualenv 19:24:41 INFO - Creating virtualenv /builds/slave/test/build/venv 19:24:41 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 19:24:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:24:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:24:42 INFO - Using real prefix '/usr' 19:24:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:24:42 INFO - Installing distribute.............................................................................................................................................................................................done. 19:24:44 INFO - Installing pip.................done. 19:24:44 INFO - Return code: 0 19:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:24:45 INFO - Reading from file tmpfile_stdout 19:24:45 INFO - Output received: 19:24:45 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) 19:24:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24: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')]} 19:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, '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 0x13776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377b30>, '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': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', '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 19:24: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', 'pip>=1.5'] in /builds/slave/test/build 19:24: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 pip>=1.5 19:24:45 INFO - Using env: {'DISPLAY': ':0', 19:24:45 INFO - 'HOME': '/home/cltbld', 19:24:45 INFO - 'LANG': 'en_US.UTF-8', 19:24:45 INFO - 'LANGUAGE': 'en_US:en', 19:24:45 INFO - 'LOGNAME': 'cltbld', 19:24:45 INFO - 'MAIL': '/var/mail/cltbld', 19:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:45 INFO - 'MOZ_NO_REMOTE': '1', 19:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:45 INFO - 'NO_EM_RESTART': '1', 19:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:45 INFO - 'PWD': '/builds/slave/test', 19:24:45 INFO - 'SHELL': '/bin/bash', 19:24:45 INFO - 'SHLVL': '1', 19:24:45 INFO - 'TERM': 'linux', 19:24:45 INFO - 'TMOUT': '86400', 19:24:45 INFO - 'USER': 'cltbld', 19:24:45 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', 19:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:45 INFO - '_': '/tools/buildbot/bin/python'} 19:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:45 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 19:24:45 INFO - Cleaning up... 19:24:45 INFO - Return code: 0 19:24:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24: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')]} 19:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24: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', '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 0x10061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, '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 0x13776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377b30>, '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': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', '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 19:24: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:24: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 psutil>=3.1.1 19:24:45 INFO - Using env: {'DISPLAY': ':0', 19:24:45 INFO - 'HOME': '/home/cltbld', 19:24:45 INFO - 'LANG': 'en_US.UTF-8', 19:24:45 INFO - 'LANGUAGE': 'en_US:en', 19:24:45 INFO - 'LOGNAME': 'cltbld', 19:24:45 INFO - 'MAIL': '/var/mail/cltbld', 19:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:45 INFO - 'MOZ_NO_REMOTE': '1', 19:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:45 INFO - 'NO_EM_RESTART': '1', 19:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:45 INFO - 'PWD': '/builds/slave/test', 19:24:45 INFO - 'SHELL': '/bin/bash', 19:24:45 INFO - 'SHLVL': '1', 19:24:45 INFO - 'TERM': 'linux', 19:24:45 INFO - 'TMOUT': '86400', 19:24:45 INFO - 'USER': 'cltbld', 19:24:45 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', 19:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:45 INFO - '_': '/tools/buildbot/bin/python'} 19:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:45 INFO - Downloading/unpacking psutil>=3.1.1 19:24: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 19:24: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 19:24: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 19:24: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 19:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:24:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:46 INFO - Installing collected packages: psutil 19:24:46 INFO - Running setup.py install for psutil 19:24:46 INFO - building 'psutil._psutil_linux' extension 19:24:46 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 19:24:47 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 19:24:48 INFO - building 'psutil._psutil_posix' extension 19:24:48 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 19:24:48 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 19:24:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:48 INFO - Successfully installed psutil 19:24:48 INFO - Cleaning up... 19:24:48 INFO - Return code: 0 19:24:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, '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 0x13776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377b30>, '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': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', '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 19:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:24:48 INFO - Using env: {'DISPLAY': ':0', 19:24:48 INFO - 'HOME': '/home/cltbld', 19:24:48 INFO - 'LANG': 'en_US.UTF-8', 19:24:48 INFO - 'LANGUAGE': 'en_US:en', 19:24:48 INFO - 'LOGNAME': 'cltbld', 19:24:48 INFO - 'MAIL': '/var/mail/cltbld', 19:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:48 INFO - 'MOZ_NO_REMOTE': '1', 19:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:48 INFO - 'NO_EM_RESTART': '1', 19:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:48 INFO - 'PWD': '/builds/slave/test', 19:24:48 INFO - 'SHELL': '/bin/bash', 19:24:48 INFO - 'SHLVL': '1', 19:24:48 INFO - 'TERM': 'linux', 19:24:48 INFO - 'TMOUT': '86400', 19:24:48 INFO - 'USER': 'cltbld', 19:24:48 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', 19:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:48 INFO - '_': '/tools/buildbot/bin/python'} 19:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:24: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 19:24: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 19:24: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 19:24: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 19:24:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:24:49 INFO - Installing collected packages: mozsystemmonitor 19:24:49 INFO - Running setup.py install for mozsystemmonitor 19:24:49 INFO - Successfully installed mozsystemmonitor 19:24:49 INFO - Cleaning up... 19:24:49 INFO - Return code: 0 19:24:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:24:49 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')]} 19:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:49 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')]} 19:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:49 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 0x10061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, '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 0x13776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377b30>, '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': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', '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 19:24:49 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 19:24:49 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 19:24:49 INFO - Using env: {'DISPLAY': ':0', 19:24:49 INFO - 'HOME': '/home/cltbld', 19:24:49 INFO - 'LANG': 'en_US.UTF-8', 19:24:49 INFO - 'LANGUAGE': 'en_US:en', 19:24:49 INFO - 'LOGNAME': 'cltbld', 19:24:49 INFO - 'MAIL': '/var/mail/cltbld', 19:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:49 INFO - 'MOZ_NO_REMOTE': '1', 19:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:49 INFO - 'NO_EM_RESTART': '1', 19:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:49 INFO - 'PWD': '/builds/slave/test', 19:24:49 INFO - 'SHELL': '/bin/bash', 19:24:49 INFO - 'SHLVL': '1', 19:24:49 INFO - 'TERM': 'linux', 19:24:49 INFO - 'TMOUT': '86400', 19:24:49 INFO - 'USER': 'cltbld', 19:24:49 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', 19:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:49 INFO - '_': '/tools/buildbot/bin/python'} 19:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:50 INFO - Downloading/unpacking jsonschema==2.5.1 19:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:24:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:24:51 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 19:24:51 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 19:24:51 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 19:24:51 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 19:24:51 INFO - Downloading functools32-3.2.3-2.tar.gz 19:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:24:51 INFO - warning: no files found matching '*.txt' 19:24:51 INFO - no previously-included directories found matching 'build' 19:24:51 INFO - no previously-included directories found matching 'dist' 19:24:51 INFO - no previously-included directories found matching '.git*' 19:24:51 INFO - Installing collected packages: jsonschema, functools32 19:24:51 INFO - Running setup.py install for functools32 19:24:51 INFO - warning: no files found matching '*.txt' 19:24:51 INFO - no previously-included directories found matching 'build' 19:24:51 INFO - no previously-included directories found matching 'dist' 19:24:51 INFO - no previously-included directories found matching '.git*' 19:24:51 INFO - Successfully installed jsonschema functools32 19:24:51 INFO - Cleaning up... 19:24:51 INFO - Return code: 0 19:24:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, '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 0x13776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377b30>, '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': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', '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 19:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:24:51 INFO - Using env: {'DISPLAY': ':0', 19:24:51 INFO - 'HOME': '/home/cltbld', 19:24:51 INFO - 'LANG': 'en_US.UTF-8', 19:24:51 INFO - 'LANGUAGE': 'en_US:en', 19:24:51 INFO - 'LOGNAME': 'cltbld', 19:24:51 INFO - 'MAIL': '/var/mail/cltbld', 19:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:51 INFO - 'MOZ_NO_REMOTE': '1', 19:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:51 INFO - 'NO_EM_RESTART': '1', 19:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:51 INFO - 'PWD': '/builds/slave/test', 19:24:51 INFO - 'SHELL': '/bin/bash', 19:24:51 INFO - 'SHLVL': '1', 19:24:51 INFO - 'TERM': 'linux', 19:24:51 INFO - 'TMOUT': '86400', 19:24:51 INFO - 'USER': 'cltbld', 19:24:51 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', 19:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:51 INFO - '_': '/tools/buildbot/bin/python'} 19:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:24:51 INFO - Cleaning up... 19:24:51 INFO - Return code: 0 19:24:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, '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 0x13776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377b30>, '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': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', '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 19:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:24:51 INFO - Using env: {'DISPLAY': ':0', 19:24:51 INFO - 'HOME': '/home/cltbld', 19:24:51 INFO - 'LANG': 'en_US.UTF-8', 19:24:51 INFO - 'LANGUAGE': 'en_US:en', 19:24:51 INFO - 'LOGNAME': 'cltbld', 19:24:51 INFO - 'MAIL': '/var/mail/cltbld', 19:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:51 INFO - 'MOZ_NO_REMOTE': '1', 19:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:51 INFO - 'NO_EM_RESTART': '1', 19:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:51 INFO - 'PWD': '/builds/slave/test', 19:24:51 INFO - 'SHELL': '/bin/bash', 19:24:51 INFO - 'SHLVL': '1', 19:24:51 INFO - 'TERM': 'linux', 19:24:51 INFO - 'TMOUT': '86400', 19:24:51 INFO - 'USER': 'cltbld', 19:24:51 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', 19:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:51 INFO - '_': '/tools/buildbot/bin/python'} 19:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:52 INFO - Downloading/unpacking blobuploader==1.2.4 19:24:52 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 19:24:52 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 19:24:52 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 19:24:52 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 19:24:53 INFO - Downloading blobuploader-1.2.4.tar.gz 19:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:24:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:24:53 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 19:24:53 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 19:24:53 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 19:24:53 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 19:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:24:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:24:53 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 19:24:53 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 19:24:53 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 19:24:53 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 19:24:53 INFO - Downloading docopt-0.6.1.tar.gz 19:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:24:53 INFO - Installing collected packages: blobuploader, requests, docopt 19:24:53 INFO - Running setup.py install for blobuploader 19:24:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:24:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:24:53 INFO - Running setup.py install for requests 19:24:54 INFO - Running setup.py install for docopt 19:24:54 INFO - Successfully installed blobuploader requests docopt 19:24:54 INFO - Cleaning up... 19:24:54 INFO - Return code: 0 19:24:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:54 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 0x10061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, '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 0x13776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377b30>, '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': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', '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 19:24:54 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 19:24:54 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 19:24:54 INFO - Using env: {'DISPLAY': ':0', 19:24:54 INFO - 'HOME': '/home/cltbld', 19:24:54 INFO - 'LANG': 'en_US.UTF-8', 19:24:54 INFO - 'LANGUAGE': 'en_US:en', 19:24:54 INFO - 'LOGNAME': 'cltbld', 19:24:54 INFO - 'MAIL': '/var/mail/cltbld', 19:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:54 INFO - 'MOZ_NO_REMOTE': '1', 19:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:54 INFO - 'NO_EM_RESTART': '1', 19:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:54 INFO - 'PWD': '/builds/slave/test', 19:24:54 INFO - 'SHELL': '/bin/bash', 19:24:54 INFO - 'SHLVL': '1', 19:24:54 INFO - 'TERM': 'linux', 19:24:54 INFO - 'TMOUT': '86400', 19:24:54 INFO - 'USER': 'cltbld', 19:24:54 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', 19:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:54 INFO - '_': '/tools/buildbot/bin/python'} 19:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:24:54 INFO - Running setup.py (path:/tmp/pip-CNqr2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:24:54 INFO - Running setup.py (path:/tmp/pip-VvkZpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:24:54 INFO - Running setup.py (path:/tmp/pip-1_qz3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:24:54 INFO - Running setup.py (path:/tmp/pip-jnyrxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:24:54 INFO - Running setup.py (path:/tmp/pip-yZVy3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:24:54 INFO - Running setup.py (path:/tmp/pip-1gPiC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:24:54 INFO - Running setup.py (path:/tmp/pip-XSHj9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:24:55 INFO - Running setup.py (path:/tmp/pip-_oOygS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:24:55 INFO - Running setup.py (path:/tmp/pip-78X4S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:24:55 INFO - Running setup.py (path:/tmp/pip-wsQQUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:24:55 INFO - Running setup.py (path:/tmp/pip-gZfNPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:24:55 INFO - Running setup.py (path:/tmp/pip-n9GV59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:24:55 INFO - Running setup.py (path:/tmp/pip-ldhfra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:24:55 INFO - Running setup.py (path:/tmp/pip-4em42d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:55 INFO - Running setup.py (path:/tmp/pip-oc09N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:24:55 INFO - Running setup.py (path:/tmp/pip-vTw1Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:24:55 INFO - Running setup.py (path:/tmp/pip-TtGBq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:24:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:24:55 INFO - Running setup.py install for manifestparser 19:24:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:24:55 INFO - Running setup.py install for mozcrash 19:24:55 INFO - Running setup.py install for mozdebug 19:24:56 INFO - Running setup.py install for mozdevice 19:24:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:24:56 INFO - Running setup.py install for mozfile 19:24:56 INFO - Running setup.py install for mozhttpd 19:24:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:24:56 INFO - Running setup.py install for mozinfo 19:24:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:24:56 INFO - Running setup.py install for mozInstall 19:24:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:24:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:24:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:24:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:24:56 INFO - Running setup.py install for mozleak 19:24:56 INFO - Running setup.py install for mozlog 19:24:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:24:56 INFO - Running setup.py install for moznetwork 19:24:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:24:56 INFO - Running setup.py install for mozprocess 19:24:56 INFO - Running setup.py install for mozprofile 19:24:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:24:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:24:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:24:57 INFO - Running setup.py install for mozrunner 19:24:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:24:57 INFO - Running setup.py install for mozscreenshot 19:24:57 INFO - Running setup.py install for moztest 19:24:57 INFO - Running setup.py install for mozversion 19:24:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:24:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:24:57 INFO - Cleaning up... 19:24:57 INFO - Return code: 0 19:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24: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')]} 19:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:57 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 0x10061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, '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 0x13776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377b30>, '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': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', '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 19:24:57 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 19:24:57 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 19:24:57 INFO - Using env: {'DISPLAY': ':0', 19:24:57 INFO - 'HOME': '/home/cltbld', 19:24:57 INFO - 'LANG': 'en_US.UTF-8', 19:24:57 INFO - 'LANGUAGE': 'en_US:en', 19:24:57 INFO - 'LOGNAME': 'cltbld', 19:24:57 INFO - 'MAIL': '/var/mail/cltbld', 19:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:57 INFO - 'MOZ_NO_REMOTE': '1', 19:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:57 INFO - 'NO_EM_RESTART': '1', 19:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:57 INFO - 'PWD': '/builds/slave/test', 19:24:57 INFO - 'SHELL': '/bin/bash', 19:24:57 INFO - 'SHLVL': '1', 19:24:57 INFO - 'TERM': 'linux', 19:24:57 INFO - 'TMOUT': '86400', 19:24:57 INFO - 'USER': 'cltbld', 19:24:57 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', 19:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:57 INFO - '_': '/tools/buildbot/bin/python'} 19:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:24:57 INFO - Running setup.py (path:/tmp/pip-xjDjMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:24:57 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)) 19:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:24:57 INFO - Running setup.py (path:/tmp/pip-u8k_v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:24:57 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)) 19:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:24:57 INFO - Running setup.py (path:/tmp/pip-9ZIFX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:24:57 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)) 19:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:24:57 INFO - Running setup.py (path:/tmp/pip-bbp27X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:24:58 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)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:24:58 INFO - Running setup.py (path:/tmp/pip-sxEMu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:24:58 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)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:24:58 INFO - Running setup.py (path:/tmp/pip-VurX_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:24:58 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)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:24:58 INFO - Running setup.py (path:/tmp/pip-kzzpdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:24:58 INFO - Running setup.py (path:/tmp/pip-jHqS45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:24:58 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)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:24:58 INFO - Running setup.py (path:/tmp/pip-eMKVxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:24:58 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)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:24:58 INFO - Running setup.py (path:/tmp/pip-VAGnyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:24:58 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)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:24:58 INFO - Running setup.py (path:/tmp/pip-vejwTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:24:58 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)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:24:58 INFO - Running setup.py (path:/tmp/pip-QPvAJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:24:58 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)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:24:58 INFO - Running setup.py (path:/tmp/pip-0QkgwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:24:58 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)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:24:58 INFO - Running setup.py (path:/tmp/pip-HC4LOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:24:58 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)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:58 INFO - Running setup.py (path:/tmp/pip-DK0ia3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:24:58 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)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:24:58 INFO - Running setup.py (path:/tmp/pip-tB4adJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:24:58 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)) 19:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:24:58 INFO - Running setup.py (path:/tmp/pip-YQcrHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:24:58 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)) 19:24:58 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)) 19:24:58 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)) 19:24:58 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)) 19:24:58 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)) 19:24:58 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)) 19:24:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:24:58 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 19:24:58 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 19:24:58 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 19:24:58 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 19:25:00 INFO - Downloading blessings-1.6.tar.gz 19:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:25:00 INFO - Installing collected packages: blessings 19:25:00 INFO - Running setup.py install for blessings 19:25:00 INFO - Successfully installed blessings 19:25:00 INFO - Cleaning up... 19:25:00 INFO - Return code: 0 19:25:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:25:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:25:00 INFO - Reading from file tmpfile_stdout 19:25:00 INFO - Current package versions: 19:25:00 INFO - argparse == 1.2.1 19:25:00 INFO - blessings == 1.6 19:25:00 INFO - blobuploader == 1.2.4 19:25:00 INFO - docopt == 0.6.1 19:25:00 INFO - functools32 == 3.2.3-2 19:25:00 INFO - jsonschema == 2.5.1 19:25:00 INFO - manifestparser == 1.1 19:25:00 INFO - mozInstall == 1.12 19:25:00 INFO - mozcrash == 1.0 19:25:00 INFO - mozdebug == 0.1 19:25:00 INFO - mozdevice == 0.51 19:25:00 INFO - mozfile == 1.2 19:25:00 INFO - mozhttpd == 0.7 19:25:00 INFO - mozinfo == 0.9 19:25:00 INFO - mozleak == 0.1 19:25:00 INFO - mozlog == 3.4 19:25:00 INFO - moznetwork == 0.27 19:25:00 INFO - mozprocess == 0.25 19:25:00 INFO - mozprofile == 0.28 19:25:00 INFO - mozrunner == 6.13 19:25:00 INFO - mozscreenshot == 0.1 19:25:00 INFO - mozsystemmonitor == 0.3 19:25:00 INFO - moztest == 0.8 19:25:00 INFO - mozversion == 1.4 19:25:00 INFO - psutil == 3.1.1 19:25:00 INFO - requests == 1.2.3 19:25:00 INFO - wsgiref == 0.1.2 19:25:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:00 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 0x10061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, '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 0x13776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377b30>, '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': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', '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 19:25:00 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 19:25:00 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 19:25:00 INFO - Using env: {'DISPLAY': ':0', 19:25:00 INFO - 'HOME': '/home/cltbld', 19:25:00 INFO - 'LANG': 'en_US.UTF-8', 19:25:00 INFO - 'LANGUAGE': 'en_US:en', 19:25:00 INFO - 'LOGNAME': 'cltbld', 19:25:00 INFO - 'MAIL': '/var/mail/cltbld', 19:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:00 INFO - 'MOZ_NO_REMOTE': '1', 19:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:00 INFO - 'NO_EM_RESTART': '1', 19:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:00 INFO - 'PWD': '/builds/slave/test', 19:25:00 INFO - 'SHELL': '/bin/bash', 19:25:00 INFO - 'SHLVL': '1', 19:25:00 INFO - 'TERM': 'linux', 19:25:00 INFO - 'TMOUT': '86400', 19:25:00 INFO - 'USER': 'cltbld', 19:25:00 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', 19:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:00 INFO - '_': '/tools/buildbot/bin/python'} 19:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 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)) 19:25:00 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:25:00 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 19:25:00 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 19:25:00 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 19:25:00 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 19:25:01 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:25:01 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)) 19:25:01 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)) 19:25:01 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)) 19:25:01 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)) 19:25:01 INFO - Installing collected packages: marionette-driver 19:25:01 INFO - Running setup.py install for marionette-driver 19:25:02 INFO - Successfully installed marionette-driver 19:25:02 INFO - Cleaning up... 19:25:02 INFO - Return code: 0 19:25:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13795c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, '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 0x13776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377b30>, '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': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', '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 19:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:25:02 INFO - Using env: {'DISPLAY': ':0', 19:25:02 INFO - 'HOME': '/home/cltbld', 19:25:02 INFO - 'LANG': 'en_US.UTF-8', 19:25:02 INFO - 'LANGUAGE': 'en_US:en', 19:25:02 INFO - 'LOGNAME': 'cltbld', 19:25:02 INFO - 'MAIL': '/var/mail/cltbld', 19:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:02 INFO - 'MOZ_NO_REMOTE': '1', 19:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:02 INFO - 'NO_EM_RESTART': '1', 19:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:02 INFO - 'PWD': '/builds/slave/test', 19:25:02 INFO - 'SHELL': '/bin/bash', 19:25:02 INFO - 'SHLVL': '1', 19:25:02 INFO - 'TERM': 'linux', 19:25:02 INFO - 'TMOUT': '86400', 19:25:02 INFO - 'USER': 'cltbld', 19:25:02 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', 19:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:02 INFO - '_': '/tools/buildbot/bin/python'} 19:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:25:02 INFO - Cleaning up... 19:25:02 INFO - Return code: 0 19:25:02 INFO - Running post-action listener: _resource_record_post_action 19:25:02 INFO - Running post-action listener: _start_resource_monitoring 19:25:02 INFO - Starting resource monitoring. 19:25:02 INFO - [mozharness: 2017-05-26 02:25:02.382666Z] Finished create-virtualenv step (success) 19:25:02 INFO - [mozharness: 2017-05-26 02:25:02.383122Z] Running install step. 19:25:02 INFO - Running pre-action listener: _resource_record_pre_action 19:25:02 INFO - Running main action method: install 19:25:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:25:02 INFO - Reading from file tmpfile_stdout 19:25:02 INFO - Detecting whether we're running mozinstall >=1.0... 19:25:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:25:02 INFO - Reading from file tmpfile_stdout 19:25:02 INFO - Output received: 19:25:02 INFO - Usage: mozinstall [options] installer 19:25:02 INFO - Options: 19:25:02 INFO - -h, --help show this help message and exit 19:25:02 INFO - -d DEST, --destination=DEST 19:25:02 INFO - Directory to install application into. [default: 19:25:02 INFO - "/builds/slave/test"] 19:25:02 INFO - --app=APP Application being installed. [default: firefox] 19:25:02 INFO - mkdir: /builds/slave/test/build/application 19:25:02 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'] 19:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:25:18 INFO - Reading from file tmpfile_stdout 19:25:18 INFO - Output received: 19:25:18 INFO - /builds/slave/test/build/application/firefox/firefox 19:25:18 INFO - Running post-action listener: _resource_record_post_action 19:25:18 INFO - [mozharness: 2017-05-26 02:25:18.250471Z] Finished install step (success) 19:25:18 INFO - [mozharness: 2017-05-26 02:25:18.250748Z] Running run-tests step. 19:25:18 INFO - Running pre-action listener: _resource_record_pre_action 19:25:18 INFO - Running main action method: run_tests 19:25:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:25:18 INFO - Python 2.7.3 19:25:18 INFO - Return code: 0 19:25:18 INFO - grabbing minidump binary from tooltool 19:25:18 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')]} 19:25:18 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 0x13767a0>, '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 0x13776a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:25:18 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 19:25:18 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 19:25:18 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 19:25:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:25:18 INFO - Return code: 0 19:25:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:25:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:25:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:25:18 INFO - ENV: RUST_BACKTRACE is now 1 19:25:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:25:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:25:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 19:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --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 19:25:18 INFO - Using env: {'DISPLAY': ':0', 19:25:18 INFO - 'HOME': '/home/cltbld', 19:25:18 INFO - 'LANG': 'en_US.UTF-8', 19:25:18 INFO - 'LANGUAGE': 'en_US:en', 19:25:18 INFO - 'LOGNAME': 'cltbld', 19:25:18 INFO - 'MAIL': '/var/mail/cltbld', 19:25:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:25:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:18 INFO - 'MOZ_NO_REMOTE': '1', 19:25:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:18 INFO - 'NO_EM_RESTART': '1', 19:25:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:18 INFO - 'PWD': '/builds/slave/test', 19:25:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:25:18 INFO - 'RUST_BACKTRACE': '1', 19:25:18 INFO - 'SHELL': '/bin/bash', 19:25:18 INFO - 'SHLVL': '1', 19:25:18 INFO - 'TERM': 'linux', 19:25:18 INFO - 'TMOUT': '86400', 19:25:18 INFO - 'USER': 'cltbld', 19:25:18 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858', 19:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:18 INFO - '_': '/tools/buildbot/bin/python'} 19:25:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 19:25:18 INFO - mozversion application_buildid: 20170526013124 19:25:18 INFO - mozversion application_changeset: 862e534ade6d17176b09aeeb5dae63fdb53eddeb 19:25:18 INFO - mozversion application_display_name: Nightly 19:25:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:25:18 INFO - mozversion application_name: Firefox 19:25:18 INFO - mozversion application_remotingname: firefox 19:25:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:25:18 INFO - mozversion application_vendor: Mozilla 19:25:18 INFO - mozversion application_version: 55.0a1 19:25:18 INFO - mozversion platform_buildid: 20170526013124 19:25:18 INFO - mozversion platform_changeset: 862e534ade6d17176b09aeeb5dae63fdb53eddeb 19:25:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:25:18 INFO - mozversion platform_version: 55.0a1 19:25:18 INFO - using testdate: 1495765518 19:25:18 INFO - actual date: 1495765518 19:25:18 INFO - starting webserver on 'localhost:51820' 19:25:18 INFO - SUITE-START | Running 2 tests 19:25:18 INFO - TEST-START | dromaeo_css 19:25:18 INFO - operating with platform_type : linux_ 19:25:18 INFO - Initialising browser for dromaeo_css test... 19:25:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51820/getInfo.html -profile /tmp/tmpD03IAl/profile 19:25:18 INFO - TEST-INFO | started process 3305 (/builds/slave/test/build/application/firefox/firefox http://localhost:51820/getInfo.html) 19:25:56 INFO - TEST-INFO | 3305: killed by SIGTERM 19:25:56 INFO - Browser initialized. 19:25:56 INFO - Running cycle 1/1 for dromaeo_css test... 19:25:56 INFO - TEST-INFO | started process 3504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD03IAl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:26:08 INFO - PID 3504 | RSS: Main: 168837120 19:26:08 INFO - PID 3504 | 19:29:13 INFO - PID 3504 | Cycle 1(1): loaded http://localhost:51820/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51820/tests/dromaeo/cssquery-ext.html) 19:29:15 INFO - PID 3504 | RSS: Main: 166330368 19:29:15 INFO - PID 3504 | 19:32:17 INFO - PID 3504 | Cycle 1(1): loaded http://localhost:51820/tests/dromaeo/cssquery-ext.html (next: http://localhost:51820/tests/dromaeo/cssquery-jquery.html) 19:32:17 INFO - PID 3504 | RSS: Main: 172404736 19:32:17 INFO - PID 3504 | 19:35:19 INFO - PID 3504 | Cycle 1(1): loaded http://localhost:51820/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51820/tests/dromaeo/cssquery-mootools.html) 19:35:20 INFO - PID 3504 | RSS: Main: 171462656 19:35:20 INFO - PID 3504 | 19:38:22 INFO - PID 3504 | Cycle 1(1): loaded http://localhost:51820/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51820/tests/dromaeo/cssquery-prototype.html) 19:38:22 INFO - PID 3504 | RSS: Main: 175403008 19:38:22 INFO - PID 3504 | 19:41:25 INFO - PID 3504 | Cycle 1(1): loaded http://localhost:51820/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51820/tests/dromaeo/cssquery-yui.html) 19:41:26 INFO - PID 3504 | RSS: Main: 174202880 19:41:26 INFO - PID 3504 | 19:44:27 INFO - PID 3504 | Cycle 1(1): loaded http://localhost:51820/tests/dromaeo/cssquery-yui.html (next: http://localhost:51820/tests/dromaeo/cssquery-dojo.html) 19:44:27 INFO - PID 3504 | RSS: Main: 171155456 19:44:27 INFO - PID 3504 | 19:44:27 INFO - PID 3504 | __start_tp_report 19:44:27 INFO - PID 3504 | _x_x_mozilla_page_load 19:44:27 INFO - PID 3504 | _x_x_mozilla_page_load_details 19:44:27 INFO - PID 3504 | |i|pagename|runs| 19:44:27 INFO - PID 3504 | |0;dojo.html;2766.1978026372353;2766.4052228770815;2781.4993301205786;2806.0038686266375;2813.0857471321824;5302.469753024696;5415.48552887475;5426.484483974026;5437.673739575624;5446.7276636168135;5380.273663055486;5387.299651045359;5403.351597808259;5493.313335833021;5520.585956053292;4770.189067858472;4819.1325561398935;4844.709317440965;4851.611871050308;4890.706557606555;4854.732989685566;4869.026194761044;4912.115819152551;4924.926126108111;4973.129702302101;4702.247640377524;4724.45668748095;4774.045190961821;4819.156647586658;4846.39420072491;4809.254565542346;4828.275758636232;4830.565249127595;4838.782254798542;4869.245266983623;4702.835400760957;4770.308305295747;4782.617390608778;4785.449673287581;4840.080384726891;5253.343332083489;5327.200919862013;5400.216968539579;5420.91868621971;5434.0218760623075;5769.798057068025;5834.474897259267;5847.0352391855295;5849.239598852122;5869.559783016291;5903.439173278532;5907.881842363172;5919.1713160157615;5927.9703601481715;5932.911006334908;5386.542143917733;5468.91796623055;5477.068898287301;5491.945080549223;5498.422665620133;6001.729922153513;6007.068904319837;6051.183090282755;6065.878682426327;6098.390160983866;5760.740766665426;5763.94236057634;5771.451712087345;5778.3354914184565;5814.825555233349;5738.8278351649515;5855.531557475391;5857.589968702235;5869.882602348014;5874.530037596982;5703.058995265735;5761;5764.221830052973;5810.157527158538;5830.737616807254;5765.682887441231;5776.740046697909;5797.333306669702;5813.476787089097;5814.854628634318;4920.163572192736;4932.309476673268;4934.605231581465;4942.20924652054;5011.674241174312;4119.217348703737;4203.138356636882;4209.095044565433;4212.241796476664;4235.216484950294;4915.48387419323;4951.059298733301;4994.076095922266;5017.974910125499;5034.270030845581;5888.293404791452;5898.557608179318;5916.230889984275;5919.289685237713;5933.732982015819;4979.651424400329;4991.675541089818;4993.525615066563;4996.900061998813;5012.749362531932;5116.513931176532;5152.355955505637;5206.843794686166;5243.449437809051;5275.314209152785;5407.161889907071;5415.350157981067;5430.619856609999;5458.181272809111;5478.780848766164;5753.798617048383;5828.970855145697;5829.271341082364;5838.591298609056;5883.0881213411985;5264.78940842362;5380;5449.591280653887;5458.5087342139395;5468.316460442445;5763.567732420001;5771.394003629558;5773.7979170730505;5777.104548794943;5818.127280907897;5769.192313076089;5830.912536312044;5836.970815145897;5889.411058894248;5896.380880007709;5661.971690141523;5710.942890571041;5735.541156707537;5749.051406517878;5758.452946970031;5721.399253078367;5725.742341594555;5737.569682273763;5741.598088133791;5742.253507044057;5594.216809646571;5658.773649053992;5667.40492248308;5670.659760414388;5673;5648.4633959773755;5673.602847800779;5679.801206957902;5749.8562535936935;5780.959427303126;5486.725663716878;5488.204210389391;5488.753006114654;5537.8061767837935;5541.030319694118 19:44:27 INFO - PID 3504 | |1;ext.html;686.6944209826626;744.1033554566748;762.874125769248;1049.2393015064074;1058.1006144776945;34273.82863085684;35510.467342989876;35512.467312990324;35584.46623300646;35589.82205088974;35915;35996.2800743985;36027.81986090072;36279.81860090703;36365.81817090917;6673.49948753843;6815.38661520463;6877.552959057671;7025.683844226996;7043.68303426347;6816.693248803816;6891.793246202622;6896.689648965808;6898.103246577938;6901;6860.416864566518;6947.79156625302;6948.722051117975;6950.54821436605;6962.234154243055;6877.071595334641;6910.44716422685;6938.791836244921;6940.6529673516625;6942.062821519081;6734.494912881553;6768.5600435972;6788.5926844389005;6802.65986700663;6805.48958828085;32824.34351312961;33116.3376732464;33129.337413251844;33170.17074573131;33280.16799580005;3058.342456371891;3061.0357737312897;3074.2775447769754;3081.6918308169;3088.567600535927;24322.635160472608;24502.142425015216;24693.135740249185;24702.752972470225;24704.505909881882;3058.1284333964713;3075.0467355119986;3091.4435401627698;3100.2869340051916;3113.548535462368;149689;149906.7513987291;156329.18354082364;160545.19727401406;161214;40037.1992560153;40204.597954020086;40442.19115617671;40462;40488.39267410991;41772.79113604413;41777.373339399936;41831.58168418277;41845.79077104656;41902.580974190474;12493.312867792358;12747.68130796719;12822.80765788514;12849.48602055926;12852.164609300366;10191.337563058378;10218.489075546193;10452.16382689383;10496.055355017932;10528.36829790215;12769.361531923367;12780.233186008869;12927.676912936522;12933.676658083623;13002.674933126558;5178.145605974972;5249.816256431007;5258.894822103536;5277.445868183862;5279.340082489689;843.9873401898976;870.9608067636972;889.0575989451203;906.7823722306599;913.4199783137756;21052.368428947157;21117;21171.68242476364;21223;21459.141634334454;947.190152419685;950.0950594058868;954.5322791831952;960.5293406230896;984.9756253496427;11046.392448415414;11118.332900026024;11124.332540047622;11169.106471482262;11250.09999200062;175803;176420;176559;176776;177064;42024;42303.788481057396;42370.15259694789;42436;42498;1187.4074613461426;1222.572099765075;1225.4301749686438;1228.8033914573625;1230.9507619695291;19198.328058517884;19584.902075489532;19815.504612384804;20376.18495260232;20513.38459846207;30139.09582712522;30160.5475917857;30319;30321.848390757907;30330.393392132475;143933;145627;145798;146021;146324;29862.85068574643;29902.850485747433;30170.24574385658;30636.540451892793;30954.53568196434;36566;36926.63073369232;36985.26029479449;37623.81188094152;38234;27795.722042779315;27828.721712783423;27992.160235192976;28271.15186544407;29292.414151717272;27940;28344;28428.28929276702;29157.41685166327;29818.55272170876;31626.841865790524;31761;31902.680973190898;31933.36133277368;32019.839900800347;26445.33886652772;26750.197494075208;27227.72772272331;28020.43959120847;28275.43449131047;21635.675464867723;22300.665490017338;22671.773282266968;22771.203007894645;22892.885535572215 19:44:27 INFO - PID 3504 | |2;jquery.html;415.1406588362092;416.27568031624975;422.6217535305903;431.50592571505626;434.55024050108125;12003.519859205644;13522.459101635948;17162.48512544624;17911.283548658055;17932.55168620785;14453.855461445382;18862.151203195855;18925.716114258295;18974.810251897477;19463.805361946375;5369.570434365261;5545.694986775726;5571.582131340146;5589.580781441408;5592.6085174037835;5224.8693782655355;5348.304720386344;5387.218853266274;5410.945890541084;5433.157860531624;5313.8937221255555;5341.946580534183;5347.7058761768085;5364.195370694388;5394.6493477924005;5258.211268309746;5277.788888444457;5347.973260133694;5372.91940620891;5403.7027963462;4890.5109489051165;4910.263460480921;4910.337104490884;4922.556969872729;4926.1379258629595;21430.357089287347;21587.568248635096;22240.443988900246;22273.109075636956;22437.663435048325;1610.0581160021402;1624.1229735942577;1626.1462732065643;1626.3819748495496;1630.4293497275978;13754.243516606582;14324.64188395288;14677.26613669323;14834.332455039548;14835.629109272246;2001.4696105532046;2005.328215047946;2039.3168288623328;2054.3939537836372;2059.330717516798;82480.58759706223;83088.16911830865;83545;83708;84021;11106.500207490682;11159.665210043711;11262.774744505228;11270.774584508428;11438.199326047097;15685.13731744765;15712.778880329504;15722.13528255934;15724.449644262397;15744.842551574568;7557.5465472070755;7761.650725717356;7764.107127680276;7846.8430631387055;7894.052713674396;6872.209695884937;7002.964985175144;7055.788326350218;7207.5675459472595;7216.170140433917;6868.141482314711;7020.543664661781;7097.21930587635;7137;7200.855982880313;2076.678114892194;2082.552251265985;2084.5726626041624;2088.133424628762;2110.6200883840747;842.7345386203326;866.1208872993916;870.3646338173169;874.4403581707712;908.7546362482093;16682.833171668128;16787.160641967854;17045.232964516377;17119.914400428166;17921.462356129337;880.5421180985851;881.1452890696015;883.2448256740395;893.946363218209;910.0580898769741;9097.090290970982;9298.628054877729;9603.37578057424;9683.515824208902;9715.222782177409;355171;360983;365532;369754;371400;76708.23291767122;76974.615126924;77178;77600.61199693965;78148;1014.2646581228697;1036.7874585709912;1041.3439533094102;1051.169576034924;1054.5149231353664;14725.631859203606;14805;14861.702765944838;15139;15570.455034073753;38392;38906.6109338903;39984.4002339971;41022;41049;47802;49616.503834961186;50632.24051639155;51137.232941505164;51209.48790512047;7967.203279671987;8049.315808156372;8194;8230.506169629842;8397.320535892968;11776.352300623548;12014.159008869296;12276.815847762113;12426.5650702225;12599.496020159091;10306.433146176732;10390.636327728493;10400.635977740743;10552.20858435605;11054.723631909266;9496.572654230715;9665.178459830711;9824.950875245579;9904.851427228454;9938.503074846374;10547.103496202908;10598.947005264925;10998.505067272152;11007.669769906915;11081.833772493257;7847.686092556462;7915.44591878563;8088.71689490865;8129.146439623754;8199.508029518249;10526.842097368393;10810.67567972962;10816.513256903301;10885.129189664965;10975.725606859893 19:44:27 INFO - PID 3504 | |3;mootools.html;1224.1064023263018;1282.1473719976216;1285.9614211573644;1291.2962435472673;1296.1315918334717;10498.737531561705;10967.177461690386;10969.780604387908;10989.285696429746;11232.719182020453;11055;11206.66380008599;11228.943855280711;11252.943735281333;11275.943620281907;2137.177186783088;2155.504234026175;2178.6078505868936;2180.967285490719;2181.901814418355;2178.7494438139656;2210.126999835064;2212.214663794354;2212.8008479236864;2225.2767850448668;2111.767705552388;2134.2423439678846;2149.5915776002507;2151.612709712259;2168.1219106261988;2081.0323199712057;2104.7263855698816;2110.504031552584;2114.2283066680707;2121.5332626822074;1983.7123617075588;2022.7370441842465;2047.4369548374168;2176.3906106290265;2184.847060705751;10709.732256693567;10785.406802625852;10798.2441229114;10798.838017429745;10803.891961080368;5336.359636843565;5472.452754724535;5488.53347465466;5494.752736126844;5517.889642207174;3070.355225402668;3171.2864605463815;3216.6622504637144;3221.822799746013;3240.270939038721;1002.413588050991;1032.5250384822991;1089.2865173311493;1102.200904344352;1130.6212418839698;16203.432879849148;16354.836451635569;16364.099974501398;16389.180540972902;16398.426055088134;4585.839495617637;4625.4911959684405;4770.785314660849;4772.6420518461255;4775.570198682066;11358.545658173745;11380.715482113013;11392.715182120513;11395.202335836411;11431.828522572168;5392.460753924576;5585.273914391184;5609.607327487119;5628.324601047901;5632.831015069554;5106.565941894906;5229.424763276036;5239.816606418757;5245.868853278622;5271.551918087006;3641.7814931104217;3782.8865134046023;3787.394016957274;3817.4423136498613;3821.38857782759;967.3325405470204;978.3200675530438;993.7416271769392;995.4176806568239;1016.9898301017043;697.2469732688684;723.8371366442614;729.0813574895669;730.8574827908507;745.0091378466734;5641.746121424546;5667.744951477193;5724.513416359656;5792.21805056312;5864.618799778001;503.19991213969234;509.5745052880812;514.565192412411;514.9871253218624;515.7163560042037;3469.271452994849;3471.5139880416764;3553.8223088845452;3571.017970058203;3586.3903136466865;12946;13815.585532434043;14160.221187834562;14166.575002749934;14172.929135354258;13926.234057126752;13937.930310348384;13980.091294066056;14026.438942442392;14053.978394644995;7419.703211871572;7828.960855195687;7970.123286438487;7976.680932762624;8046;6639.4688424924925;6693.330666933268;6790.083338749206;6928.896066558905;7003.6498175092065;12757.681057973625;12960.092793504742;13035.934820326218;13074.28091454979;13164.539241126515;12853.614391568268;13085.41115649817;13206.867931320949;13297.26865022433;13468.259245741578;8495.702650407206;8579.35654825878;8703.47779133254;8705.3035757138;8712.21590056898;9655.565499552678;9657.71026869195;9722.951385243028;9766.706998790047;9802.705918822447;8185.918140818754;8347.666093356198;8410.537420441935;8443.49339039635;8553.657853685783;7993.4804237726685;8069;8116.634751436318;8134.349252059703;8187.426880118334;7537.434692397982;7753.612319383896;7820.726274580363;7822.687092516463;7831.334336581226;5151.587872970078;5185.974070129625;5248.868778280574;5256.816011439581;5318.521333080042;5141.305923700402;5301.496357845998;5351.678899266057;5369.838904832861;5494.2582751328055 19:44:28 INFO - PID 3504 | |4;prototype.html;380.74680337575506;383.373184842782;383.4574077680083;389.8927794856414;392.8664254153587;5591.692456914868;5592.7203639818;5597.104463285875;5609.35492418372;5613.859653508664;5263.3683957925;5343.412224655294;5449.4005659377435;5467.879084787619;5473.562115030798;4295.871123866289;4298.14037192562;4299.828006879721;4301.204277208726;4312.266914624505;4268.914621707564;4281.293586558214;4281.657467402601;4282.164977829325;4282.935755963663;3950.3876899080688;4071.2875246831836;4243.702940794145;4258.084511829956;4258.382534532507;4095.9590404096175;4102.425660407545;4102.487189101363;4112.498937887679;4126.09225970286;3512.877049303262;3542.0613537412605;3545.663161999606;3557.8221088945706;3563.3051554946796;5251.842444726664;5432.728363581805;5435.809746658848;5438.782448702047;5456.0997435423105;4836.347093142451;4839.467658557556;4839.572326163755;4842.12841688496;4858.635602329804;5776.220210271644;5820.5634577406445;5848.64908105515;5849;5894.204282421904;3898.785566793825;3937.9255960204264;3976.363781794928;3977.4033894915706;3993.3610622300293;6007.519398448114;6134.539909506805;6259.843503912393;6266.717997690115;6267.153934218868;4065.776382299002;4084.509858816961;4085.7957102144774;4092.283850326181;4099.385092236129;4118.691098167649;4130.752154870657;4136.482939632546;4140.7577726682475;4144.41978123063;4720.858374248778;4758.191107511731;4795.544423279783;4811.302361157613;4827.058723548875;5843.912341314884;5889.352171261158;5899.852503687443;5907.434529849594;5929.495992840657;1423.0394483723446;1426.3367534096694;1428.6071330384227;1431.5419065898811;1441.4666573367922;918.7060140754894;936.7096200177966;967.1778987860263;970.4807927758616;972.2950860626131;5129.743512824419;5135.768890399941;5137.255098010767;5146.202338637517;5152.871178220575;6072.180255665517;6091.817245482643;6120.296165940885;6124.938750612526;6127.835711214855;4920.047971217241;5073.594112470993;5100.438951715309;5110.923336149961;5132.538071573576;3208.4545627243424;3239;3241;3243.918902027421;3249.902502924916;5480.561555075585;5616.5787565932715;5618.241537392481;5628.577856660685;5630.831075067755;6178.671585609116;6215.192025036717;6254.528736551258;6255.593386429868;6288.119663247149;5569.860753481195;5578.63738856973;5590.692511911884;5614.164846752364;5618.85952851182;5935.169076329231;6039.698015099315;6070.878582428415;6081.179040829431;6095.329513753572;5942.405759424023;5942.494887934574;5978.74446366268;5986.371430999682;6013.858151280767;5410.918836217381;5590.776368945197;5600.747966341606;5615.803446879339;5621.10062390032;4123.731957422758;4144.191882582867;4149.460570125864;4163.5420103789165;4170.91658166841;5985;6156.753729850935;6164.722587483484;6169.784057557964;6180.3201647817805;5885.529157667462;5904.789518148855;5953.672548009901;5958.612690175125;5986.191864098291;5884.676342801187;5891.617044892068;5895.823125306248;5923.407659234214;5957.731902064331;5664.405237450173;5780.797672081625;5806.622569532967;5845.853853653693;5849.883002339844;5930.7924222652;5943.494802941798;5953.7023148843255;5954.493868021266;5954.880902382015;5633.211350410864;5642.407547207484;5740.39725828782;5751.913721294268;5805.680687562224 19:44:28 INFO - PID 3504 | |5;yui.html;750.6096829648579;756.3646536908996;759.1232126893439;766.8006318357229;772.8222508822969;11927.403629818518;12270.386480675976;13213.405396757156;13798.310084495784;13884.236366999823;15033.6993260135;15659.608509787233;15668.059916404995;15682.607934801636;15694.529164125066;881.2641444393906;881.5680316644862;881.7178502879082;881.8236352729448;898.0525545549459;902.1249388093539;907.3240435875282;909.9044600316971;909.963601455941;920.8434566123775;960.2318145483586;965.179597342257;965.6764983730459;965.8892273885053;972.0716715536646;962.8122516109362;965.2760429677742;966.3235734985539;969.8836139663285;972.3436680240809;692.504859025799;706.8091615263901;708.3730898155118;714.153727832515;720.0099862688803;13580.728385432334;13720.65698357539;13801.930990345085;13802.17186968785;13828.308584570732;14460.855391446055;15290.847091529165;15333.31000104998;15361.462348817739;15426;12140.878591214063;12389.75220495585;12400.627981160489;12550;12629.684257893534;2795.398989217328;2796;2839.2475993861644;2840.204742672055;2841.247069526577;72700.63649681771;74981;75306.24693753046;76657.61671191608;78182;11783.88216117845;12014.519419223134;12099.697507562205;12103.939480302719;12126.090543209119;19755.604887902162;19832.20671173166;20212.191512339636;20219.29232476856;20246;6464.676766161673;6489.480841532666;6505.154329937078;6507.12153859223;6513.446357059703;2949.439606474763;3002.9549556756665;3011.9247018824703;3014.6382434108045;3029.9242518936762;3684.889453316405;3685.355062863988;3728.645778651078;3770.2836461072307;3783.735138540331;790.3953475591177;790.9802254943672;798.3533337996241;824.0729179672868;828.958552072394;565.7482420322917;572.1475002246623;591.4794980417291;602.1118849696662;607.3986753114385;9881.80236395268;10214.693559193236;10353.9482302588;10449.268551201343;10490.580376784843;599.7690889007677;601.0533409879457;604.3593790581997;605.4399680295709;618.0543768034913;4663.670853806717;4806.591439727592;4837.37114175155;4868.902621947612;4998.4251811042195;80259.59870200611;81540;82944.17055829485;86072.13927860766;87341.12658873457;74085.6295718518;75608.24391756122;75708;76003.61998189974;76240.61879690677;68270;68491.65754171296;68963.31036689569;69113.3088669117;69357.65321173362;9207.769805754642;9612.567434465325;9634.855477167988;9869.210463162786;9982.251331150337;26596.335091622863;27018.1894543164;27238.182854514398;27935;29797.553036704034;49169;49281.75359123181;49871.75064124656;51249.7437512825;51630.741846290526;13255.469781209029;14528.346224419714;14739.55781326562;14813.407463701331;14907.105573665614;14982.925085374503;15016.774748379;15251.084934903942;15828.68342633164;15951.361945522049;14522.782158267846;14554.563363099123;14803.481878134213;14837.703245935238;14932.850671493146;14442.711145776815;15041.924790375979;15222.847771522143;15461.304241309394;15474.84525154734;14708.117512949257;14708.338124784197;14709.55871323862;14937.551873443814;15177.6205594861;9965.950170249102;10070.8489372658;10313.535890884777;10377.844332335171;10426.113780328757;11557.942210288895;11852.111091668332;11862.881371186179;12025;12142.150049496451 19:44:28 INFO - PID 3504 | __end_tp_report 19:44:28 INFO - PID 3504 | __start_cc_report 19:44:28 INFO - PID 3504 | _x_x_mozilla_cycle_collect,343 19:44:28 INFO - PID 3504 | __end_cc_report 19:44:28 INFO - PID 3504 | __startTimestamp1495766667989__endTimestamp 19:44:28 INFO - PID 3504 | 19:44:28 INFO - PID 3504 | ------- Summary: start ------- 19:44:28 INFO - PID 3504 | Number of tests: 6 19:44:28 INFO - PID 3504 | 19:44:28 INFO - PID 3504 | [#0] dojo.html Cycles:165 Average:5346.07 Median:5488.20 stddev:633.57 (11.5%) stddev-sans-first:602.33 19:44:28 INFO - PID 3504 | Values: 2766.2 2766.4 2781.5 2806.0 2813.1 5302.5 5415.5 5426.5 5437.7 5446.7 5380.3 5387.3 5403.4 5493.3 5520.6 4770.2 4819.1 4844.7 4851.6 4890.7 4854.7 4869.0 4912.1 4924.9 4973.1 4702.2 4724.5 4774.0 4819.2 4846.4 4809.3 4828.3 4830.6 4838.8 4869.2 4702.8 4770.3 4782.6 4785.4 4840.1 5253.3 5327.2 5400.2 5420.9 5434.0 5769.8 5834.5 5847.0 5849.2 5869.6 5903.4 5907.9 5919.2 5928.0 5932.9 5386.5 5468.9 5477.1 5491.9 5498.4 6001.7 6007.1 6051.2 6065.9 6098.4 5760.7 5763.9 5771.5 5778.3 5814.8 5738.8 5855.5 5857.6 5869.9 5874.5 5703.1 5761.0 5764.2 5810.2 5830.7 5765.7 5776.7 5797.3 5813.5 5814.9 4920.2 4932.3 4934.6 4942.2 5011.7 4119.2 4203.1 4209.1 4212.2 4235.2 4915.5 4951.1 4994.1 5018.0 5034.3 5888.3 5898.6 5916.2 5919.3 5933.7 4979.7 4991.7 4993.5 4996.9 5012.7 5116.5 5152.4 5206.8 5243.4 5275.3 5407.2 5415.4 5430.6 5458.2 5478.8 5753.8 5829.0 5829.3 5838.6 5883.1 5264.8 5380.0 5449.6 5458.5 5468.3 5763.6 5771.4 5773.8 5777.1 5818.1 5769.2 5830.9 5837.0 5889.4 5896.4 5662.0 5710.9 5735.5 5749.1 5758.5 5721.4 5725.7 5737.6 5741.6 5742.3 5594.2 5658.8 5667.4 5670.7 5673.0 5648.5 5673.6 5679.8 5749.9 5781.0 5486.7 5488.2 5488.8 5537.8 5541.0 19:44:28 INFO - PID 3504 | 19:44:28 INFO - PID 3504 | [#1] ext.html Cycles:180 Average:30711.73 Median:3078.37 stddev:41220.96 (1339.1%) stddev-sans-first:41274.94 19:44:28 INFO - PID 3504 | Values: 686.7 744.1 762.9 1049.2 1058.1 34273.8 35510.5 35512.5 35584.5 35589.8 35915.0 35996.3 36027.8 36279.8 36365.8 6673.5 6815.4 6877.6 7025.7 7043.7 6816.7 6891.8 6896.7 6898.1 6901.0 6860.4 6947.8 6948.7 6950.5 6962.2 6877.1 6910.4 6938.8 6940.7 6942.1 6734.5 6768.6 6788.6 6802.7 6805.5 32824.3 33116.3 33129.3 33170.2 33280.2 3058.3 3061.0 3074.3 3081.7 3088.6 24322.6 24502.1 24693.1 24702.8 24704.5 3058.1 3075.0 3091.4 3100.3 3113.5 149689.0 149906.8 156329.2 160545.2 161214.0 40037.2 40204.6 40442.2 40462.0 40488.4 41772.8 41777.4 41831.6 41845.8 41902.6 12493.3 12747.7 12822.8 12849.5 12852.2 10191.3 10218.5 10452.2 10496.1 10528.4 12769.4 12780.2 12927.7 12933.7 13002.7 5178.1 5249.8 5258.9 5277.4 5279.3 844.0 871.0 889.1 906.8 913.4 21052.4 21117.0 21171.7 21223.0 21459.1 947.2 950.1 954.5 960.5 985.0 11046.4 11118.3 11124.3 11169.1 11250.1 175803.0 176420.0 176559.0 176776.0 177064.0 42024.0 42303.8 42370.2 42436.0 42498.0 1187.4 1222.6 1225.4 1228.8 1231.0 19198.3 19584.9 19815.5 20376.2 20513.4 30139.1 30160.5 30319.0 30321.8 30330.4 143933.0 145627.0 145798.0 146021.0 146324.0 29862.9 29902.9 30170.2 30636.5 30954.5 36566.0 36926.6 36985.3 37623.8 38234.0 27795.7 27828.7 27992.2 28271.2 29292.4 27940.0 28344.0 28428.3 29157.4 29818.6 31626.8 31761.0 31902.7 31933.4 32019.8 26445.3 26750.2 27227.7 28020.4 28275.4 21635.7 22300.7 22671.8 22771.2 22892.9 19:44:28 INFO - PID 3504 | 19:44:28 INFO - PID 3504 | [#2] jquery.html Cycles:180 Average:24495.77 Median:415.71 stddev:60646.21 (14588.7%) stddev-sans-first:60789.39 19:44:28 INFO - PID 3504 | Values: 415.1 416.3 422.6 431.5 434.6 12003.5 13522.5 17162.5 17911.3 17932.6 14453.9 18862.2 18925.7 18974.8 19463.8 5369.6 5545.7 5571.6 5589.6 5592.6 5224.9 5348.3 5387.2 5410.9 5433.2 5313.9 5341.9 5347.7 5364.2 5394.6 5258.2 5277.8 5348.0 5372.9 5403.7 4890.5 4910.3 4910.3 4922.6 4926.1 21430.4 21587.6 22240.4 22273.1 22437.7 1610.1 1624.1 1626.1 1626.4 1630.4 13754.2 14324.6 14677.3 14834.3 14835.6 2001.5 2005.3 2039.3 2054.4 2059.3 82480.6 83088.2 83545.0 83708.0 84021.0 11106.5 11159.7 11262.8 11270.8 11438.2 15685.1 15712.8 15722.1 15724.4 15744.8 7557.5 7761.7 7764.1 7846.8 7894.1 6872.2 7003.0 7055.8 7207.6 7216.2 6868.1 7020.5 7097.2 7137.0 7200.9 2076.7 2082.6 2084.6 2088.1 2110.6 842.7 866.1 870.4 874.4 908.8 16682.8 16787.2 17045.2 17119.9 17921.5 880.5 881.1 883.2 893.9 910.1 9097.1 9298.6 9603.4 9683.5 9715.2 355171.0 360983.0 365532.0 369754.0 371400.0 76708.2 76974.6 77178.0 77600.6 78148.0 1014.3 1036.8 1041.3 1051.2 1054.5 14725.6 14805.0 14861.7 15139.0 15570.5 38392.0 38906.6 39984.4 41022.0 41049.0 47802.0 49616.5 50632.2 51137.2 51209.5 7967.2 8049.3 8194.0 8230.5 8397.3 11776.4 12014.2 12276.8 12426.6 12599.5 10306.4 10390.6 10400.6 10552.2 11054.7 9496.6 9665.2 9825.0 9904.9 9938.5 10547.1 10598.9 10998.5 11007.7 11081.8 7847.7 7915.4 8088.7 8129.1 8199.5 10526.8 10810.7 10816.5 10885.1 10975.7 19:44:28 INFO - PID 3504 | 19:44:28 INFO - PID 3504 | [#3] mootools.html Cycles:180 Average:6526.46 Median:3614.09 stddev:4396.08 (121.6%) stddev-sans-first:4390.35 19:44:28 INFO - PID 3504 | Values: 1224.1 1282.1 1286.0 1291.3 1296.1 10498.7 10967.2 10969.8 10989.3 11232.7 11055.0 11206.7 11228.9 11252.9 11275.9 2137.2 2155.5 2178.6 2181.0 2181.9 2178.7 2210.1 2212.2 2212.8 2225.3 2111.8 2134.2 2149.6 2151.6 2168.1 2081.0 2104.7 2110.5 2114.2 2121.5 1983.7 2022.7 2047.4 2176.4 2184.8 10709.7 10785.4 10798.2 10798.8 10803.9 5336.4 5472.5 5488.5 5494.8 5517.9 3070.4 3171.3 3216.7 3221.8 3240.3 1002.4 1032.5 1089.3 1102.2 1130.6 16203.4 16354.8 16364.1 16389.2 16398.4 4585.8 4625.5 4770.8 4772.6 4775.6 11358.5 11380.7 11392.7 11395.2 11431.8 5392.5 5585.3 5609.6 5628.3 5632.8 5106.6 5229.4 5239.8 5245.9 5271.6 3641.8 3782.9 3787.4 3817.4 3821.4 967.3 978.3 993.7 995.4 1017.0 697.2 723.8 729.1 730.9 745.0 5641.7 5667.7 5724.5 5792.2 5864.6 503.2 509.6 514.6 515.0 515.7 3469.3 3471.5 3553.8 3571.0 3586.4 12946.0 13815.6 14160.2 14166.6 14172.9 13926.2 13937.9 13980.1 14026.4 14054.0 7419.7 7829.0 7970.1 7976.7 8046.0 6639.5 6693.3 6790.1 6928.9 7003.6 12757.7 12960.1 13035.9 13074.3 13164.5 12853.6 13085.4 13206.9 13297.3 13468.3 8495.7 8579.4 8703.5 8705.3 8712.2 9655.6 9657.7 9723.0 9766.7 9802.7 8185.9 8347.7 8410.5 8443.5 8553.7 7993.5 8069.0 8116.6 8134.3 8187.4 7537.4 7753.6 7820.7 7822.7 7831.3 5151.6 5186.0 5248.9 5256.8 5318.5 5141.3 5301.5 5351.7 5369.8 5494.3 19:44:28 INFO - PID 3504 | 19:44:28 INFO - PID 3504 | [#4] prototype.html Cycles:180 Average:4817.50 Median:5477.06 stddev:1447.13 (26.4%) stddev-sans-first:1412.35 19:44:28 INFO - PID 3504 | Values: 380.7 383.4 383.5 389.9 392.9 5591.7 5592.7 5597.1 5609.4 5613.9 5263.4 5343.4 5449.4 5467.9 5473.6 4295.9 4298.1 4299.8 4301.2 4312.3 4268.9 4281.3 4281.7 4282.2 4282.9 3950.4 4071.3 4243.7 4258.1 4258.4 4096.0 4102.4 4102.5 4112.5 4126.1 3512.9 3542.1 3545.7 3557.8 3563.3 5251.8 5432.7 5435.8 5438.8 5456.1 4836.3 4839.5 4839.6 4842.1 4858.6 5776.2 5820.6 5848.6 5849.0 5894.2 3898.8 3937.9 3976.4 3977.4 3993.4 6007.5 6134.5 6259.8 6266.7 6267.2 4065.8 4084.5 4085.8 4092.3 4099.4 4118.7 4130.8 4136.5 4140.8 4144.4 4720.9 4758.2 4795.5 4811.3 4827.1 5843.9 5889.4 5899.9 5907.4 5929.5 1423.0 1426.3 1428.6 1431.5 1441.5 918.7 936.7 967.2 970.5 972.3 5129.7 5135.8 5137.3 5146.2 5152.9 6072.2 6091.8 6120.3 6124.9 6127.8 4920.0 5073.6 5100.4 5110.9 5132.5 3208.5 3239.0 3241.0 3243.9 3249.9 5480.6 5616.6 5618.2 5628.6 5630.8 6178.7 6215.2 6254.5 6255.6 6288.1 5569.9 5578.6 5590.7 5614.2 5618.9 5935.2 6039.7 6070.9 6081.2 6095.3 5942.4 5942.5 5978.7 5986.4 6013.9 5410.9 5590.8 5600.7 5615.8 5621.1 4123.7 4144.2 4149.5 4163.5 4170.9 5985.0 6156.8 6164.7 6169.8 6180.3 5885.5 5904.8 5953.7 5958.6 5986.2 5884.7 5891.6 5895.8 5923.4 5957.7 5664.4 5780.8 5806.6 5845.9 5849.9 5930.8 5943.5 5953.7 5954.5 5954.9 5633.2 5642.4 5740.4 5751.9 5805.7 19:44:28 INFO - PID 3504 | 19:44:28 INFO - PID 3504 | [#5] yui.html Cycles:180 Average:17450.43 Median:3749.46 stddev:22845.32 (609.3%) stddev-sans-first:22874.99 19:44:28 INFO - PID 3504 | Values: 750.6 756.4 759.1 766.8 772.8 11927.4 12270.4 13213.4 13798.3 13884.2 15033.7 15659.6 15668.1 15682.6 15694.5 881.3 881.6 881.7 881.8 898.1 902.1 907.3 909.9 910.0 920.8 960.2 965.2 965.7 965.9 972.1 962.8 965.3 966.3 969.9 972.3 692.5 706.8 708.4 714.2 720.0 13580.7 13720.7 13801.9 13802.2 13828.3 14460.9 15290.8 15333.3 15361.5 15426.0 12140.9 12389.8 12400.6 12550.0 12629.7 2795.4 2796.0 2839.2 2840.2 2841.2 72700.6 74981.0 75306.2 76657.6 78182.0 11783.9 12014.5 12099.7 12103.9 12126.1 19755.6 19832.2 20212.2 20219.3 20246.0 6464.7 6489.5 6505.2 6507.1 6513.4 2949.4 3003.0 3011.9 3014.6 3029.9 3684.9 3685.4 3728.6 3770.3 3783.7 790.4 791.0 798.4 824.1 829.0 565.7 572.1 591.5 602.1 607.4 9881.8 10214.7 10353.9 10449.3 10490.6 599.8 601.1 604.4 605.4 618.1 4663.7 4806.6 4837.4 4868.9 4998.4 80259.6 81540.0 82944.2 86072.1 87341.1 74085.6 75608.2 75708.0 76003.6 76240.6 68270.0 68491.7 68963.3 69113.3 69357.7 9207.8 9612.6 9634.9 9869.2 9982.3 26596.3 27018.2 27238.2 27935.0 29797.6 49169.0 49281.8 49871.8 51249.7 51630.7 13255.5 14528.3 14739.6 14813.4 14907.1 14982.9 15016.8 15251.1 15828.7 15951.4 14522.8 14554.6 14803.5 14837.7 14932.9 14442.7 15041.9 15222.8 15461.3 15474.8 14708.1 14708.3 14709.6 14937.6 15177.6 9966.0 10070.8 10313.5 10377.8 10426.1 11557.9 11852.1 11862.9 12025.0 12142.2 19:44:28 INFO - PID 3504 | -------- Summary: end -------- 19:44:28 INFO - PID 3504 | 19:44:28 INFO - TEST-INFO | 3504: exit 0 19:44:28 INFO - TEST-OK | dromaeo_css | took 1149856ms 19:44:28 INFO - TEST-START | kraken 19:44:28 INFO - operating with platform_type : linux_ 19:44:28 INFO - Initialising browser for kraken test... 19:44:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51820/getInfo.html -profile /tmp/tmp1GzxpX/profile 19:44:28 INFO - TEST-INFO | started process 3907 (/builds/slave/test/build/application/firefox/firefox http://localhost:51820/getInfo.html) 19:45:03 INFO - TEST-INFO | 3907: killed by SIGTERM 19:45:03 INFO - Browser initialized. 19:45:03 INFO - Running cycle 1/1 for kraken test... 19:45:03 INFO - TEST-INFO | started process 4104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1GzxpX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:45:15 INFO - PID 4104 | RSS: Main: 168693760 19:45:15 INFO - PID 4104 | 19:45:18 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51820/tests/kraken/driver.html?testName=audio-beat-detection) 19:45:19 INFO - PID 4104 | RSS: Main: 174620672 19:45:19 INFO - PID 4104 | 19:45:22 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51820/tests/kraken/driver.html?testName=audio-dft) 19:45:22 INFO - PID 4104 | RSS: Main: 174022656 19:45:22 INFO - PID 4104 | 19:45:25 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51820/tests/kraken/driver.html?testName=audio-fft) 19:45:26 INFO - PID 4104 | RSS: Main: 171458560 19:45:26 INFO - PID 4104 | 19:45:28 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51820/tests/kraken/driver.html?testName=audio-oscillator) 19:45:29 INFO - PID 4104 | RSS: Main: 171773952 19:45:29 INFO - PID 4104 | 19:45:31 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51820/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:45:31 INFO - PID 4104 | RSS: Main: 172236800 19:45:31 INFO - PID 4104 | 19:45:34 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51820/tests/kraken/driver.html?testName=imaging-darkroom) 19:45:35 INFO - PID 4104 | RSS: Main: 172912640 19:45:35 INFO - PID 4104 | 19:45:39 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51820/tests/kraken/driver.html?testName=imaging-desaturate) 19:45:39 INFO - PID 4104 | RSS: Main: 172650496 19:45:39 INFO - PID 4104 | 19:45:42 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51820/tests/kraken/driver.html?testName=json-parse-financial) 19:45:43 INFO - PID 4104 | RSS: Main: 172699648 19:45:43 INFO - PID 4104 | 19:45:44 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51820/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:45:45 INFO - PID 4104 | RSS: Main: 173060096 19:45:45 INFO - PID 4104 | 19:45:47 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51820/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:45:47 INFO - PID 4104 | RSS: Main: 172847104 19:45:47 INFO - PID 4104 | 19:45:49 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51820/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:45:50 INFO - PID 4104 | RSS: Main: 172965888 19:45:50 INFO - PID 4104 | 19:45:53 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:45:54 INFO - PID 4104 | RSS: Main: 172359680 19:45:54 INFO - PID 4104 | 19:45:57 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:45:57 INFO - PID 4104 | RSS: Main: 172597248 19:45:57 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | Cycle 1(1): loaded http://localhost:51820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51820/tests/kraken/driver.html?testName=ai-astar) 19:45:59 INFO - PID 4104 | RSS: Main: 174166016 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | __start_tp_report 19:45:59 INFO - PID 4104 | _x_x_mozilla_page_load 19:45:59 INFO - PID 4104 | _x_x_mozilla_page_load_details 19:45:59 INFO - PID 4104 | |i|pagename|runs| 19:45:59 INFO - PID 4104 | |0;ai-astar;103;112;112;111;112;112;113;111;111;112 19:45:59 INFO - PID 4104 | |1;audio-beat-detection;150;122;126;181;125;127;124;127;147;128 19:45:59 INFO - PID 4104 | |2;audio-dft;165;163;164;164;169;169;169;162;162;163 19:45:59 INFO - PID 4104 | |3;audio-fft;73;76;73;115;78;75;75;75;98;76 19:45:59 INFO - PID 4104 | |4;audio-oscillator;84;84;106;83;84;88;98;86;90;118 19:45:59 INFO - PID 4104 | |5;imaging-gaussian-blur;114;115;113;114;114;114;114;114;115;115 19:45:59 INFO - PID 4104 | |6;imaging-darkroom;149;150;149;150;150;152;150;151;151;150 19:45:59 INFO - PID 4104 | |7;imaging-desaturate;95;96;94;94;95;94;94;95;94;94 19:45:59 INFO - PID 4104 | |8;json-parse-financial;53;55;54;53;56;59;54;55;55;58 19:45:59 INFO - PID 4104 | |9;json-stringify-tinderbox;56;56;57;57;56;56;56;57;56;56 19:45:59 INFO - PID 4104 | |10;stanford-crypto-aes;87;86;96;87;86;87;88;88;125;86 19:45:59 INFO - PID 4104 | |11;stanford-crypto-ccm;134;139;136;133;134;135;138;135;142;133 19:45:59 INFO - PID 4104 | |12;stanford-crypto-pbkdf2;195;198;193;196;206;200;193;193;188;191 19:45:59 INFO - PID 4104 | |13;stanford-crypto-sha256-iterative;75;73;76;72;72;72;73;74;73;71 19:45:59 INFO - PID 4104 | __end_tp_report 19:45:59 INFO - PID 4104 | __start_cc_report 19:45:59 INFO - PID 4104 | _x_x_mozilla_cycle_collect,882 19:45:59 INFO - PID 4104 | __end_cc_report 19:45:59 INFO - PID 4104 | __startTimestamp1495766759884__endTimestamp 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | ------- Summary: start ------- 19:45:59 INFO - PID 4104 | Number of tests: 14 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.85 (2.5%) stddev-sans-first:0.67 19:45:59 INFO - PID 4104 | Values: 103.0 112.0 112.0 111.0 112.0 112.0 113.0 111.0 111.0 112.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:127.50 stddev:18.64 (14.6%) stddev-sans-first:19.04 19:45:59 INFO - PID 4104 | Values: 150.0 122.0 126.0 181.0 125.0 127.0 124.0 127.0 147.0 128.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:2.91 (1.8%) stddev-sans-first:3.08 19:45:59 INFO - PID 4104 | Values: 165.0 163.0 164.0 164.0 169.0 169.0 169.0 162.0 162.0 163.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:13.90 (18.4%) stddev-sans-first:14.40 19:45:59 INFO - PID 4104 | Values: 73.0 76.0 73.0 115.0 78.0 75.0 75.0 75.0 98.0 76.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:85.00 stddev:11.72 (13.8%) stddev-sans-first:12.06 19:45:59 INFO - PID 4104 | Values: 84.0 84.0 106.0 83.0 84.0 88.0 98.0 86.0 90.0 118.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 19:45:59 INFO - PID 4104 | Values: 114.0 115.0 113.0 114.0 114.0 114.0 114.0 114.0 115.0 115.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 19:45:59 INFO - PID 4104 | Values: 149.0 150.0 149.0 150.0 150.0 152.0 150.0 151.0 151.0 150.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 19:45:59 INFO - PID 4104 | Values: 95.0 96.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.99 (3.6%) stddev-sans-first:1.94 19:45:59 INFO - PID 4104 | Values: 53.0 55.0 54.0 53.0 56.0 59.0 54.0 55.0 55.0 58.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 19:45:59 INFO - PID 4104 | Values: 56.0 56.0 57.0 57.0 56.0 56.0 56.0 57.0 56.0 56.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:87.00 stddev:12.10 (13.9%) stddev-sans-first:12.72 19:45:59 INFO - PID 4104 | Values: 87.0 86.0 96.0 87.0 86.0 87.0 88.0 88.0 125.0 86.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:135.50 stddev:2.92 (2.2%) stddev-sans-first:3.02 19:45:59 INFO - PID 4104 | Values: 134.0 139.0 136.0 133.0 134.0 135.0 138.0 135.0 142.0 133.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.30 Median:195.50 stddev:5.08 (2.6%) stddev-sans-first:5.39 19:45:59 INFO - PID 4104 | Values: 195.0 198.0 193.0 196.0 206.0 200.0 193.0 193.0 188.0 191.0 19:45:59 INFO - PID 4104 | 19:45:59 INFO - PID 4104 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.00 stddev:1.52 (2.1%) stddev-sans-first:1.45 19:45:59 INFO - PID 4104 | Values: 75.0 73.0 76.0 72.0 72.0 72.0 73.0 74.0 73.0 71.0 19:45:59 INFO - PID 4104 | -------- Summary: end -------- 19:45:59 INFO - PID 4104 | 19:46:00 INFO - TEST-INFO | 4104: exit 0 19:46:00 INFO - TEST-OK | kraken | took 92241ms 19:46:00 INFO - SUITE-END | took 1242s 19:46:01 INFO - Completed test suite (00:20:42) 19:46:01 INFO - javascript benchmark 19:46:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6814.848751897651, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2766.1978026372353, 2766.4052228770815, 2781.4993301205786, 2806.0038686266375, 2813.0857471321824, 5302.469753024696, 5415.48552887475, 5426.484483974026, 5437.673739575624, 5446.7276636168135, 5380.273663055486, 5387.299651045359, 5403.351597808259, 5493.313335833021, 5520.585956053292, 4770.189067858472, 4819.1325561398935, 4844.709317440965, 4851.611871050308, 4890.706557606555, 4854.732989685566, 4869.026194761044, 4912.115819152551, 4924.926126108111, 4973.129702302101, 4702.247640377524, 4724.45668748095, 4774.045190961821, 4819.156647586658, 4846.39420072491, 4809.254565542346, 4828.275758636232, 4830.565249127595, 4838.782254798542, 4869.245266983623, 4702.835400760957, 4770.308305295747, 4782.617390608778, 4785.449673287581, 4840.080384726891, 5253.343332083489, 5327.200919862013, 5400.216968539579, 5420.91868621971, 5434.0218760623075, 5769.798057068025, 5834.474897259267, 5847.0352391855295, 5849.239598852122, 5869.559783016291, 5903.439173278532, 5907.881842363172, 5919.1713160157615, 5927.9703601481715, 5932.911006334908, 5386.542143917733, 5468.91796623055, 5477.068898287301, 5491.945080549223, 5498.422665620133, 6001.729922153513, 6007.068904319837, 6051.183090282755, 6065.878682426327, 6098.390160983866, 5760.740766665426, 5763.94236057634, 5771.451712087345, 5778.3354914184565, 5814.825555233349, 5738.8278351649515, 5855.531557475391, 5857.589968702235, 5869.882602348014, 5874.530037596982, 5703.058995265735, 5761.0, 5764.221830052973, 5810.157527158538, 5830.737616807254, 5765.682887441231, 5776.740046697909, 5797.333306669702, 5813.476787089097, 5814.854628634318, 4920.163572192736, 4932.309476673268, 4934.605231581465, 4942.20924652054, 5011.674241174312, 4119.217348703737, 4203.138356636882, 4209.095044565433, 4212.241796476664, 4235.216484950294, 4915.48387419323, 4951.059298733301, 4994.076095922266, 5017.974910125499, 5034.270030845581, 5888.293404791452, 5898.557608179318, 5916.230889984275, 5919.289685237713, 5933.732982015819, 4979.651424400329, 4991.675541089818, 4993.525615066563, 4996.900061998813, 5012.749362531932, 5116.513931176532, 5152.355955505637, 5206.843794686166, 5243.449437809051, 5275.314209152785, 5407.161889907071, 5415.350157981067, 5430.619856609999, 5458.181272809111, 5478.780848766164, 5753.798617048383, 5828.970855145697, 5829.271341082364, 5838.591298609056, 5883.0881213411985, 5264.78940842362, 5380.0, 5449.591280653887, 5458.5087342139395, 5468.316460442445, 5763.567732420001, 5771.394003629558, 5773.7979170730505, 5777.104548794943, 5818.127280907897, 5769.192313076089, 5830.912536312044, 5836.970815145897, 5889.411058894248, 5896.380880007709, 5661.971690141523, 5710.942890571041, 5735.541156707537, 5749.051406517878, 5758.452946970031, 5721.399253078367, 5725.742341594555, 5737.569682273763, 5741.598088133791, 5742.253507044057, 5594.216809646571, 5658.773649053992, 5667.40492248308, 5670.659760414388, 5673.0, 5648.4633959773755, 5673.602847800779, 5679.801206957902, 5749.8562535936935, 5780.959427303126, 5486.725663716878, 5488.204210389391, 5488.753006114654, 5537.8061767837935, 5541.030319694118], "value": 5299.283789681639, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.6944209826626, 744.1033554566748, 762.874125769248, 1049.2393015064074, 1058.1006144776945, 34273.82863085684, 35510.467342989876, 35512.467312990324, 35584.46623300646, 35589.82205088974, 35915.0, 35996.2800743985, 36027.81986090072, 36279.81860090703, 36365.81817090917, 6673.49948753843, 6815.38661520463, 6877.552959057671, 7025.683844226996, 7043.68303426347, 6816.693248803816, 6891.793246202622, 6896.689648965808, 6898.103246577938, 6901.0, 6860.416864566518, 6947.79156625302, 6948.722051117975, 6950.54821436605, 6962.234154243055, 6877.071595334641, 6910.44716422685, 6938.791836244921, 6940.6529673516625, 6942.062821519081, 6734.494912881553, 6768.5600435972, 6788.5926844389005, 6802.65986700663, 6805.48958828085, 32824.34351312961, 33116.3376732464, 33129.337413251844, 33170.17074573131, 33280.16799580005, 3058.342456371891, 3061.0357737312897, 3074.2775447769754, 3081.6918308169, 3088.567600535927, 24322.635160472608, 24502.142425015216, 24693.135740249185, 24702.752972470225, 24704.505909881882, 3058.1284333964713, 3075.0467355119986, 3091.4435401627698, 3100.2869340051916, 3113.548535462368, 149689.0, 149906.7513987291, 156329.18354082364, 160545.19727401406, 161214.0, 40037.1992560153, 40204.597954020086, 40442.19115617671, 40462.0, 40488.39267410991, 41772.79113604413, 41777.373339399936, 41831.58168418277, 41845.79077104656, 41902.580974190474, 12493.312867792358, 12747.68130796719, 12822.80765788514, 12849.48602055926, 12852.164609300366, 10191.337563058378, 10218.489075546193, 10452.16382689383, 10496.055355017932, 10528.36829790215, 12769.361531923367, 12780.233186008869, 12927.676912936522, 12933.676658083623, 13002.674933126558, 5178.145605974972, 5249.816256431007, 5258.894822103536, 5277.445868183862, 5279.340082489689, 843.9873401898976, 870.9608067636972, 889.0575989451203, 906.7823722306599, 913.4199783137756, 21052.368428947157, 21117.0, 21171.68242476364, 21223.0, 21459.141634334454, 947.190152419685, 950.0950594058868, 954.5322791831952, 960.5293406230896, 984.9756253496427, 11046.392448415414, 11118.332900026024, 11124.332540047622, 11169.106471482262, 11250.09999200062, 175803.0, 176420.0, 176559.0, 176776.0, 177064.0, 42024.0, 42303.788481057396, 42370.15259694789, 42436.0, 42498.0, 1187.4074613461426, 1222.572099765075, 1225.4301749686438, 1228.8033914573625, 1230.9507619695291, 19198.328058517884, 19584.902075489532, 19815.504612384804, 20376.18495260232, 20513.38459846207, 30139.09582712522, 30160.5475917857, 30319.0, 30321.848390757907, 30330.393392132475, 143933.0, 145627.0, 145798.0, 146021.0, 146324.0, 29862.85068574643, 29902.850485747433, 30170.24574385658, 30636.540451892793, 30954.53568196434, 36566.0, 36926.63073369232, 36985.26029479449, 37623.81188094152, 38234.0, 27795.722042779315, 27828.721712783423, 27992.160235192976, 28271.15186544407, 29292.414151717272, 27940.0, 28344.0, 28428.28929276702, 29157.41685166327, 29818.55272170876, 31626.841865790524, 31761.0, 31902.680973190898, 31933.36133277368, 32019.839900800347, 26445.33886652772, 26750.197494075208, 27227.72772272331, 28020.43959120847, 28275.43449131047, 21635.675464867723, 22300.665490017338, 22671.773282266968, 22771.203007894645, 22892.885535572215], "value": 14627.319633792296, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.1406588362092, 416.27568031624975, 422.6217535305903, 431.50592571505626, 434.55024050108125, 12003.519859205644, 13522.459101635948, 17162.48512544624, 17911.283548658055, 17932.55168620785, 14453.855461445382, 18862.151203195855, 18925.716114258295, 18974.810251897477, 19463.805361946375, 5369.570434365261, 5545.694986775726, 5571.582131340146, 5589.580781441408, 5592.6085174037835, 5224.8693782655355, 5348.304720386344, 5387.218853266274, 5410.945890541084, 5433.157860531624, 5313.8937221255555, 5341.946580534183, 5347.7058761768085, 5364.195370694388, 5394.6493477924005, 5258.211268309746, 5277.788888444457, 5347.973260133694, 5372.91940620891, 5403.7027963462, 4890.5109489051165, 4910.263460480921, 4910.337104490884, 4922.556969872729, 4926.1379258629595, 21430.357089287347, 21587.568248635096, 22240.443988900246, 22273.109075636956, 22437.663435048325, 1610.0581160021402, 1624.1229735942577, 1626.1462732065643, 1626.3819748495496, 1630.4293497275978, 13754.243516606582, 14324.64188395288, 14677.26613669323, 14834.332455039548, 14835.629109272246, 2001.4696105532046, 2005.328215047946, 2039.3168288623328, 2054.3939537836372, 2059.330717516798, 82480.58759706223, 83088.16911830865, 83545.0, 83708.0, 84021.0, 11106.500207490682, 11159.665210043711, 11262.774744505228, 11270.774584508428, 11438.199326047097, 15685.13731744765, 15712.778880329504, 15722.13528255934, 15724.449644262397, 15744.842551574568, 7557.5465472070755, 7761.650725717356, 7764.107127680276, 7846.8430631387055, 7894.052713674396, 6872.209695884937, 7002.964985175144, 7055.788326350218, 7207.5675459472595, 7216.170140433917, 6868.141482314711, 7020.543664661781, 7097.21930587635, 7137.0, 7200.855982880313, 2076.678114892194, 2082.552251265985, 2084.5726626041624, 2088.133424628762, 2110.6200883840747, 842.7345386203326, 866.1208872993916, 870.3646338173169, 874.4403581707712, 908.7546362482093, 16682.833171668128, 16787.160641967854, 17045.232964516377, 17119.914400428166, 17921.462356129337, 880.5421180985851, 881.1452890696015, 883.2448256740395, 893.946363218209, 910.0580898769741, 9097.090290970982, 9298.628054877729, 9603.37578057424, 9683.515824208902, 9715.222782177409, 355171.0, 360983.0, 365532.0, 369754.0, 371400.0, 76708.23291767122, 76974.615126924, 77178.0, 77600.61199693965, 78148.0, 1014.2646581228697, 1036.7874585709912, 1041.3439533094102, 1051.169576034924, 1054.5149231353664, 14725.631859203606, 14805.0, 14861.702765944838, 15139.0, 15570.455034073753, 38392.0, 38906.6109338903, 39984.4002339971, 41022.0, 41049.0, 47802.0, 49616.503834961186, 50632.24051639155, 51137.232941505164, 51209.48790512047, 7967.203279671987, 8049.315808156372, 8194.0, 8230.506169629842, 8397.320535892968, 11776.352300623548, 12014.159008869296, 12276.815847762113, 12426.5650702225, 12599.496020159091, 10306.433146176732, 10390.636327728493, 10400.635977740743, 10552.20858435605, 11054.723631909266, 9496.572654230715, 9665.178459830711, 9824.950875245579, 9904.851427228454, 9938.503074846374, 10547.103496202908, 10598.947005264925, 10998.505067272152, 11007.669769906915, 11081.833772493257, 7847.686092556462, 7915.44591878563, 8088.71689490865, 8129.146439623754, 8199.508029518249, 10526.842097368393, 10810.67567972962, 10816.513256903301, 10885.129189664965, 10975.725606859893], "value": 8705.036889445992, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1224.1064023263018, 1282.1473719976216, 1285.9614211573644, 1291.2962435472673, 1296.1315918334717, 10498.737531561705, 10967.177461690386, 10969.780604387908, 10989.285696429746, 11232.719182020453, 11055.0, 11206.66380008599, 11228.943855280711, 11252.943735281333, 11275.943620281907, 2137.177186783088, 2155.504234026175, 2178.6078505868936, 2180.967285490719, 2181.901814418355, 2178.7494438139656, 2210.126999835064, 2212.214663794354, 2212.8008479236864, 2225.2767850448668, 2111.767705552388, 2134.2423439678846, 2149.5915776002507, 2151.612709712259, 2168.1219106261988, 2081.0323199712057, 2104.7263855698816, 2110.504031552584, 2114.2283066680707, 2121.5332626822074, 1983.7123617075588, 2022.7370441842465, 2047.4369548374168, 2176.3906106290265, 2184.847060705751, 10709.732256693567, 10785.406802625852, 10798.2441229114, 10798.838017429745, 10803.891961080368, 5336.359636843565, 5472.452754724535, 5488.53347465466, 5494.752736126844, 5517.889642207174, 3070.355225402668, 3171.2864605463815, 3216.6622504637144, 3221.822799746013, 3240.270939038721, 1002.413588050991, 1032.5250384822991, 1089.2865173311493, 1102.200904344352, 1130.6212418839698, 16203.432879849148, 16354.836451635569, 16364.099974501398, 16389.180540972902, 16398.426055088134, 4585.839495617637, 4625.4911959684405, 4770.785314660849, 4772.6420518461255, 4775.570198682066, 11358.545658173745, 11380.715482113013, 11392.715182120513, 11395.202335836411, 11431.828522572168, 5392.460753924576, 5585.273914391184, 5609.607327487119, 5628.324601047901, 5632.831015069554, 5106.565941894906, 5229.424763276036, 5239.816606418757, 5245.868853278622, 5271.551918087006, 3641.7814931104217, 3782.8865134046023, 3787.394016957274, 3817.4423136498613, 3821.38857782759, 967.3325405470204, 978.3200675530438, 993.7416271769392, 995.4176806568239, 1016.9898301017043, 697.2469732688684, 723.8371366442614, 729.0813574895669, 730.8574827908507, 745.0091378466734, 5641.746121424546, 5667.744951477193, 5724.513416359656, 5792.21805056312, 5864.618799778001, 503.19991213969234, 509.5745052880812, 514.565192412411, 514.9871253218624, 515.7163560042037, 3469.271452994849, 3471.5139880416764, 3553.8223088845452, 3571.017970058203, 3586.3903136466865, 12946.0, 13815.585532434043, 14160.221187834562, 14166.575002749934, 14172.929135354258, 13926.234057126752, 13937.930310348384, 13980.091294066056, 14026.438942442392, 14053.978394644995, 7419.703211871572, 7828.960855195687, 7970.123286438487, 7976.680932762624, 8046.0, 6639.4688424924925, 6693.330666933268, 6790.083338749206, 6928.896066558905, 7003.6498175092065, 12757.681057973625, 12960.092793504742, 13035.934820326218, 13074.28091454979, 13164.539241126515, 12853.614391568268, 13085.41115649817, 13206.867931320949, 13297.26865022433, 13468.259245741578, 8495.702650407206, 8579.35654825878, 8703.47779133254, 8705.3035757138, 8712.21590056898, 9655.565499552678, 9657.71026869195, 9722.951385243028, 9766.706998790047, 9802.705918822447, 8185.918140818754, 8347.666093356198, 8410.537420441935, 8443.49339039635, 8553.657853685783, 7993.4804237726685, 8069.0, 8116.634751436318, 8134.349252059703, 8187.426880118334, 7537.434692397982, 7753.612319383896, 7820.726274580363, 7822.687092516463, 7831.334336581226, 5151.587872970078, 5185.974070129625, 5248.868778280574, 5256.816011439581, 5318.521333080042, 5141.305923700402, 5301.496357845998, 5351.678899266057, 5369.838904832861, 5494.2582751328055], "value": 4745.562820677899, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.74680337575506, 383.373184842782, 383.4574077680083, 389.8927794856414, 392.8664254153587, 5591.692456914868, 5592.7203639818, 5597.104463285875, 5609.35492418372, 5613.859653508664, 5263.3683957925, 5343.412224655294, 5449.4005659377435, 5467.879084787619, 5473.562115030798, 4295.871123866289, 4298.14037192562, 4299.828006879721, 4301.204277208726, 4312.266914624505, 4268.914621707564, 4281.293586558214, 4281.657467402601, 4282.164977829325, 4282.935755963663, 3950.3876899080688, 4071.2875246831836, 4243.702940794145, 4258.084511829956, 4258.382534532507, 4095.9590404096175, 4102.425660407545, 4102.487189101363, 4112.498937887679, 4126.09225970286, 3512.877049303262, 3542.0613537412605, 3545.663161999606, 3557.8221088945706, 3563.3051554946796, 5251.842444726664, 5432.728363581805, 5435.809746658848, 5438.782448702047, 5456.0997435423105, 4836.347093142451, 4839.467658557556, 4839.572326163755, 4842.12841688496, 4858.635602329804, 5776.220210271644, 5820.5634577406445, 5848.64908105515, 5849.0, 5894.204282421904, 3898.785566793825, 3937.9255960204264, 3976.363781794928, 3977.4033894915706, 3993.3610622300293, 6007.519398448114, 6134.539909506805, 6259.843503912393, 6266.717997690115, 6267.153934218868, 4065.776382299002, 4084.509858816961, 4085.7957102144774, 4092.283850326181, 4099.385092236129, 4118.691098167649, 4130.752154870657, 4136.482939632546, 4140.7577726682475, 4144.41978123063, 4720.858374248778, 4758.191107511731, 4795.544423279783, 4811.302361157613, 4827.058723548875, 5843.912341314884, 5889.352171261158, 5899.852503687443, 5907.434529849594, 5929.495992840657, 1423.0394483723446, 1426.3367534096694, 1428.6071330384227, 1431.5419065898811, 1441.4666573367922, 918.7060140754894, 936.7096200177966, 967.1778987860263, 970.4807927758616, 972.2950860626131, 5129.743512824419, 5135.768890399941, 5137.255098010767, 5146.202338637517, 5152.871178220575, 6072.180255665517, 6091.817245482643, 6120.296165940885, 6124.938750612526, 6127.835711214855, 4920.047971217241, 5073.594112470993, 5100.438951715309, 5110.923336149961, 5132.538071573576, 3208.4545627243424, 3239.0, 3241.0, 3243.918902027421, 3249.902502924916, 5480.561555075585, 5616.5787565932715, 5618.241537392481, 5628.577856660685, 5630.831075067755, 6178.671585609116, 6215.192025036717, 6254.528736551258, 6255.593386429868, 6288.119663247149, 5569.860753481195, 5578.63738856973, 5590.692511911884, 5614.164846752364, 5618.85952851182, 5935.169076329231, 6039.698015099315, 6070.878582428415, 6081.179040829431, 6095.329513753572, 5942.405759424023, 5942.494887934574, 5978.74446366268, 5986.371430999682, 6013.858151280767, 5410.918836217381, 5590.776368945197, 5600.747966341606, 5615.803446879339, 5621.10062390032, 4123.731957422758, 4144.191882582867, 4149.460570125864, 4163.5420103789165, 4170.91658166841, 5985.0, 6156.753729850935, 6164.722587483484, 6169.784057557964, 6180.3201647817805, 5885.529157667462, 5904.789518148855, 5953.672548009901, 5958.612690175125, 5986.191864098291, 5884.676342801187, 5891.617044892068, 5895.823125306248, 5923.407659234214, 5957.731902064331, 5664.405237450173, 5780.797672081625, 5806.622569532967, 5845.853853653693, 5849.883002339844, 5930.7924222652, 5943.494802941798, 5953.7023148843255, 5954.493868021266, 5954.880902382015, 5633.211350410864, 5642.407547207484, 5740.39725828782, 5751.913721294268, 5805.680687562224], "value": 4368.185356073676, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.6096829648579, 756.3646536908996, 759.1232126893439, 766.8006318357229, 772.8222508822969, 11927.403629818518, 12270.386480675976, 13213.405396757156, 13798.310084495784, 13884.236366999823, 15033.6993260135, 15659.608509787233, 15668.059916404995, 15682.607934801636, 15694.529164125066, 881.2641444393906, 881.5680316644862, 881.7178502879082, 881.8236352729448, 898.0525545549459, 902.1249388093539, 907.3240435875282, 909.9044600316971, 909.963601455941, 920.8434566123775, 960.2318145483586, 965.179597342257, 965.6764983730459, 965.8892273885053, 972.0716715536646, 962.8122516109362, 965.2760429677742, 966.3235734985539, 969.8836139663285, 972.3436680240809, 692.504859025799, 706.8091615263901, 708.3730898155118, 714.153727832515, 720.0099862688803, 13580.728385432334, 13720.65698357539, 13801.930990345085, 13802.17186968785, 13828.308584570732, 14460.855391446055, 15290.847091529165, 15333.31000104998, 15361.462348817739, 15426.0, 12140.878591214063, 12389.75220495585, 12400.627981160489, 12550.0, 12629.684257893534, 2795.398989217328, 2796.0, 2839.2475993861644, 2840.204742672055, 2841.247069526577, 72700.63649681771, 74981.0, 75306.24693753046, 76657.61671191608, 78182.0, 11783.88216117845, 12014.519419223134, 12099.697507562205, 12103.939480302719, 12126.090543209119, 19755.604887902162, 19832.20671173166, 20212.191512339636, 20219.29232476856, 20246.0, 6464.676766161673, 6489.480841532666, 6505.154329937078, 6507.12153859223, 6513.446357059703, 2949.439606474763, 3002.9549556756665, 3011.9247018824703, 3014.6382434108045, 3029.9242518936762, 3684.889453316405, 3685.355062863988, 3728.645778651078, 3770.2836461072307, 3783.735138540331, 790.3953475591177, 790.9802254943672, 798.3533337996241, 824.0729179672868, 828.958552072394, 565.7482420322917, 572.1475002246623, 591.4794980417291, 602.1118849696662, 607.3986753114385, 9881.80236395268, 10214.693559193236, 10353.9482302588, 10449.268551201343, 10490.580376784843, 599.7690889007677, 601.0533409879457, 604.3593790581997, 605.4399680295709, 618.0543768034913, 4663.670853806717, 4806.591439727592, 4837.37114175155, 4868.902621947612, 4998.4251811042195, 80259.59870200611, 81540.0, 82944.17055829485, 86072.13927860766, 87341.12658873457, 74085.6295718518, 75608.24391756122, 75708.0, 76003.61998189974, 76240.61879690677, 68270.0, 68491.65754171296, 68963.31036689569, 69113.3088669117, 69357.65321173362, 9207.769805754642, 9612.567434465325, 9634.855477167988, 9869.210463162786, 9982.251331150337, 26596.335091622863, 27018.1894543164, 27238.182854514398, 27935.0, 29797.553036704034, 49169.0, 49281.75359123181, 49871.75064124656, 51249.7437512825, 51630.741846290526, 13255.469781209029, 14528.346224419714, 14739.55781326562, 14813.407463701331, 14907.105573665614, 14982.925085374503, 15016.774748379, 15251.084934903942, 15828.68342633164, 15951.361945522049, 14522.782158267846, 14554.563363099123, 14803.481878134213, 14837.703245935238, 14932.850671493146, 14442.711145776815, 15041.924790375979, 15222.847771522143, 15461.304241309394, 15474.84525154734, 14708.117512949257, 14708.338124784197, 14709.55871323862, 14937.551873443814, 15177.6205594861, 9965.950170249102, 10070.8489372658, 10313.535890884777, 10377.844332335171, 10426.113780328757, 11557.942210288895, 11852.111091668332, 11862.881371186179, 12025.0, 12142.150049496451], "value": 7160.861157576082, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 111.0, 112.0, 112.0, 113.0, 111.0, 111.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 126.0, 181.0, 125.0, 127.0, 124.0, 127.0, 147.0, 128.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 164.0, 169.0, 169.0, 169.0, 162.0, 162.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 73.0, 115.0, 78.0, 75.0, 75.0, 75.0, 98.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 106.0, 83.0, 84.0, 88.0, 98.0, 86.0, 90.0, 118.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 150.0, 150.0, 152.0, 150.0, 151.0, 151.0, 150.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 53.0, 56.0, 59.0, 54.0, 55.0, 55.0, 58.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 96.0, 87.0, 86.0, 87.0, 88.0, 88.0, 125.0, 86.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 139.0, 136.0, 133.0, 134.0, 135.0, 138.0, 135.0, 142.0, 133.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 198.0, 193.0, 196.0, 206.0, 200.0, 193.0, 193.0, 188.0, 191.0], "value": 195.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 76.0, 72.0, 72.0, 72.0, 73.0, 74.0, 73.0, 71.0], "value": 73.1, "unit": "score"}]}]} 19:46:01 INFO - Return code: 0 19:46:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:46:01 INFO - # TBPL SUCCESS # 19:46:01 INFO - Running post-action listener: _resource_record_post_action 19:46:01 INFO - [mozharness: 2017-05-26 02:46:01.218079Z] Finished run-tests step (success) 19:46:01 INFO - Running post-run listener: _resource_record_post_run 19:46:01 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 8581120; Write bytes: 413028352; Read time: 2260; Write time: 416440 19:46:01 INFO - TinderboxPrint: CPU usage
12.6% 19:46:01 INFO - TinderboxPrint: I/O read bytes / time
8,581,120 / 2,260 19:46:01 INFO - TinderboxPrint: I/O write bytes / time
413,028,352 / 416,440 19:46:01 INFO - TinderboxPrint: CPU idle
8,770.4 (87.3%) 19:46:01 INFO - TinderboxPrint: CPU user
1,212.8 (12.1%) 19:46:01 INFO - TinderboxPrint: Swap in / out
0 / 0 19:46:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106053632; Read time: 0; Write time: 136228 19:46:01 INFO - run-tests - Wall time: 1243s; CPU: 13.0%; Read bytes: 6836224; Write bytes: 306974720; Read time: 2208; Write time: 280212 19:46:01 INFO - Running post-run listener: _upload_blobber_files 19:46:01 INFO - Blob upload gear active. 19:46:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:46:01 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 19:46:01 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:46:01 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:46:02 INFO - (blobuploader) - INFO - Open directory for files ... 19:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:46:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:03 INFO - (blobuploader) - INFO - Done attempting. 19:46:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:46:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:46:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:06 INFO - (blobuploader) - INFO - Done attempting. 19:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:07 INFO - (blobuploader) - INFO - Done attempting. 19:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:46:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:08 INFO - (blobuploader) - INFO - Done attempting. 19:46:08 INFO - (blobuploader) - INFO - Iteration through files over. 19:46:08 INFO - Return code: 0 19:46:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:46:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:46:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc79c970919af825f3086796e3c74f9bbe8d65b61f3f72eb1d60e228d42569e3f9df2b74eba6b0d4c3b75dde0d4f235043a5ef21f4e817d2bf39dd398f465ddd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64b46b70c5ab07b06422dd1a5219a4241c14856e1202f09f534508c1f0dd09250766f44dfc9bb22bcc86e040365f635abcefc2df4a6641ac9b1cb1b4d498d72f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f29405fffa1ba6e6c6e174b535feeb6320e00069fca2c4d3c67d33cc6a230e27c68f1e3af686c0bc450608ab189ffbe980e5d583257eb4f686b168e5b29dbf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d3f7b73a18eb9c49f90455ec904c008f223953b508d6a57c783ef7c0fa2f93ec05cbf4ee7f361416e6800943b5ad8b590137c632a9d5a16431ac07c6b0d0e99"} 19:46:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:46:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:46:08 INFO - Contents: 19:46:08 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc79c970919af825f3086796e3c74f9bbe8d65b61f3f72eb1d60e228d42569e3f9df2b74eba6b0d4c3b75dde0d4f235043a5ef21f4e817d2bf39dd398f465ddd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64b46b70c5ab07b06422dd1a5219a4241c14856e1202f09f534508c1f0dd09250766f44dfc9bb22bcc86e040365f635abcefc2df4a6641ac9b1cb1b4d498d72f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f29405fffa1ba6e6c6e174b535feeb6320e00069fca2c4d3c67d33cc6a230e27c68f1e3af686c0bc450608ab189ffbe980e5d583257eb4f686b168e5b29dbf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d3f7b73a18eb9c49f90455ec904c008f223953b508d6a57c783ef7c0fa2f93ec05cbf4ee7f361416e6800943b5ad8b590137c632a9d5a16431ac07c6b0d0e99"} 19:46:08 INFO - Running post-run listener: copy_logs_to_upload_dir 19:46:08 INFO - Copying logs to upload dir... 19:46:08 INFO - mkdir: /builds/slave/test/build/upload/logs 19:46:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1318.990389 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-25 19:46:08.539742) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 19:46:08.547245) ========= 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=ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc79c970919af825f3086796e3c74f9bbe8d65b61f3f72eb1d60e228d42569e3f9df2b74eba6b0d4c3b75dde0d4f235043a5ef21f4e817d2bf39dd398f465ddd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64b46b70c5ab07b06422dd1a5219a4241c14856e1202f09f534508c1f0dd09250766f44dfc9bb22bcc86e040365f635abcefc2df4a6641ac9b1cb1b4d498d72f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f29405fffa1ba6e6c6e174b535feeb6320e00069fca2c4d3c67d33cc6a230e27c68f1e3af686c0bc450608ab189ffbe980e5d583257eb4f686b168e5b29dbf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d3f7b73a18eb9c49f90455ec904c008f223953b508d6a57c783ef7c0fa2f93ec05cbf4ee7f361416e6800943b5ad8b590137c632a9d5a16431ac07c6b0d0e99"} build_url:https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/FHEJyh-hTU2GpJXElrX5FQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc79c970919af825f3086796e3c74f9bbe8d65b61f3f72eb1d60e228d42569e3f9df2b74eba6b0d4c3b75dde0d4f235043a5ef21f4e817d2bf39dd398f465ddd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64b46b70c5ab07b06422dd1a5219a4241c14856e1202f09f534508c1f0dd09250766f44dfc9bb22bcc86e040365f635abcefc2df4a6641ac9b1cb1b4d498d72f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f29405fffa1ba6e6c6e174b535feeb6320e00069fca2c4d3c67d33cc6a230e27c68f1e3af686c0bc450608ab189ffbe980e5d583257eb4f686b168e5b29dbf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d3f7b73a18eb9c49f90455ec904c008f223953b508d6a57c783ef7c0fa2f93ec05cbf4ee7f361416e6800943b5ad8b590137c632a9d5a16431ac07c6b0d0e99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 19:46:08.571233) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:46:08.571568) ========= 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=ea65d483da93c827905c2090000001f5-1495765446.876111-1027479858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:46:08.656695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 19:46:08.660071) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 19:46:08.660387) ========= ========= Total master_lag: 0.06 =========