builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-087 starttime: 1506386228.07 results: success (0) revision: e6b3498a39b94616ba36798fe0b71a3090b1b14c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 17:37:08.071799) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 17:37:08.072344) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 17:37:08.072658) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 17:37:08.107166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:37:08.108054) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 17:37: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.8M=0s 2017-09-25 17:37:08 (68.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151895 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:37:08.288743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:37:08.289122) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018096 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:37:08.339674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 17:37:08.340055) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e6b3498a39b94616ba36798fe0b71a3090b1b14c --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 e6b3498a39b94616ba36798fe0b71a3090b1b14c --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=ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 17:37:08,393 truncating revision to first 12 chars 2017-09-25 17:37:08,393 Setting DEBUG logging. 2017-09-25 17:37:08,393 attempt 1/10 2017-09-25 17:37:08,393 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e6b3498a39b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 17:37:09,280 unpacking tar archive at: mozilla-central-e6b3498a39b9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.167820 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 17:37:09.522768) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 17:37:09.523118) ========= script_repo_revision: e6b3498a39b94616ba36798fe0b71a3090b1b14c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 17:37:09.523505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 17:37:09.523772) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 17:37:09.536378) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-25 17:37:09.536775) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:37:09 INFO - MultiFileLogger online at 20170925 17:37:09 in /builds/slave/test 17:37:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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 17:37:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:37:09 INFO - {'append_to_log': False, 17:37:09 INFO - 'base_work_dir': '/builds/slave/test', 17:37:09 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:37:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:37:09 INFO - 'branch': 'Firefox-Non-PGO', 17:37:09 INFO - 'buildbot_json_path': 'buildprops.json', 17:37:09 INFO - 'code_coverage': False, 17:37:09 INFO - 'config_files': ('talos/linux_config.py',), 17:37:09 INFO - 'default_actions': ('clobber', 17:37:09 INFO - 'read-buildbot-config', 17:37:09 INFO - 'download-and-extract', 17:37:09 INFO - 'populate-webroot', 17:37:09 INFO - 'create-virtualenv', 17:37:09 INFO - 'install', 17:37:09 INFO - 'setup-mitmproxy', 17:37:09 INFO - 'run-tests'), 17:37:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:37:09 INFO - 'disable_ccov_upload': False, 17:37:09 INFO - 'disable_stylo': False, 17:37:09 INFO - 'download_minidump_stackwalk': True, 17:37:09 INFO - 'download_symbols': 'ondemand', 17:37:09 INFO - 'enable_stylo': False, 17:37:09 INFO - 'enable_webrender': False, 17:37:09 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:37:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:37:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:37:09 INFO - 'gecko_profile': False, 17:37:09 INFO - 'gecko_profile_interval': 0, 17:37:09 INFO - 'installer_path': 'installer.exe', 17:37:09 INFO - 'log_level': 'info', 17:37:09 INFO - 'log_name': 'talos', 17:37:09 INFO - 'log_to_console': True, 17:37:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:37:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:37:09 INFO - 'opt_config_files': (), 17:37:09 INFO - 'pip_index': False, 17:37:09 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:37:09 INFO - 'system_bits': '32', 17:37:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:37:09 INFO - 'title': 'talos-linux64-ix-087', 17:37:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:37:09 INFO - 'use_talos_json': True, 17:37:09 INFO - 'verify': 'False', 17:37:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:37:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:37:09 INFO - 'work_dir': 'build'} 17:37:09 INFO - [mozharness: 2017-09-26 00:37:09.914314Z] Running clobber step. 17:37:09 INFO - Running pre-action listener: _resource_record_pre_action 17:37:09 INFO - Running main action method: clobber 17:37:09 INFO - rmtree: /builds/slave/test/build 17:37:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:37:10 INFO - Running post-action listener: _resource_record_post_action 17:37:10 INFO - [mozharness: 2017-09-26 00:37:10.859670Z] Finished clobber step (success) 17:37:10 INFO - [mozharness: 2017-09-26 00:37:10.859770Z] Running read-buildbot-config step. 17:37:10 INFO - Running pre-action listener: _resource_record_pre_action 17:37:10 INFO - Running main action method: read_buildbot_config 17:37:10 INFO - Using buildbot properties: 17:37:10 INFO - { 17:37:10 INFO - "project": "", 17:37:10 INFO - "product": "firefox", 17:37:10 INFO - "who": "kwierso@gmail.com", 17:37:10 INFO - "installer_path": "public/build/target.tar.bz2", 17:37:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:37:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:37:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 17:37:10 INFO - "stage_platform": "linux64", 17:37:10 INFO - "basedir": "/builds/slave/test", 17:37:10 INFO - "buildnumber": 42, 17:37:10 INFO - "platform": "ubuntu64_hw", 17:37:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:37:10 INFO - "slavebuilddir": "test", 17:37:10 INFO - "taskId": "CWxkMy9QQ02S98LgIt1xtA", 17:37:10 INFO - "branch": "mozilla-central", 17:37:10 INFO - "script_repo_revision": "production", 17:37:10 INFO - "revision": "e6b3498a39b94616ba36798fe0b71a3090b1b14c", 17:37:10 INFO - "slavename": "talos-linux64-ix-087", 17:37:10 INFO - "repo_path": "mozilla-central" 17:37:10 INFO - } 17:37:10 INFO - Finding installer, test and symbols from parent task. 17:37:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CWxkMy9QQ02S98LgIt1xtA'}, attempt #1 17:37:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CWxkMy9QQ02S98LgIt1xtA'}, attempt #1 17:37:11 INFO - Task dependencies: YCRCLS0WQIqLyHDorScFGQ 17:37:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ'}, attempt #1 17:37:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2 17:37:12 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.test_packages.json 17:37:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.crashreporter-symbols.zip 17:37:12 INFO - Running post-action listener: _resource_record_post_action 17:37:12 INFO - [mozharness: 2017-09-26 00:37:12.164344Z] Finished read-buildbot-config step (success) 17:37:12 INFO - [mozharness: 2017-09-26 00:37:12.164560Z] Running download-and-extract step. 17:37:12 INFO - Running pre-action listener: _resource_record_pre_action 17:37:12 INFO - Running main action method: download_and_extract 17:37:12 INFO - mkdir: /builds/slave/test/build/tests 17:37: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')]} 17:37:12 INFO - trying https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.test_packages.json 17:37:12 INFO - Downloading https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:37:12 INFO - Downloaded 989 bytes. 17:37:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:37:12 INFO - Using the following test package requirements: 17:37:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:37:12 INFO - u'common': [u'target.common.tests.zip'], 17:37:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:37:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:37:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:37:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:37:12 INFO - u'mozbase': [u'target.common.tests.zip'], 17:37:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:37:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:37:12 INFO - u'web-platform': [u'target.common.tests.zip', 17:37:12 INFO - u'target.web-platform.tests.tar.gz'], 17:37:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:37:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:37:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.common.tests.zip 17:37:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:37:12 INFO - Fetch https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.common.tests.zip into memory 17:37:13 INFO - Content-Length response header: 54943837 17:37:13 INFO - Bytes received: 54943837 17:37:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.talos.tests.zip 17:37:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:37:24 INFO - Fetch https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.talos.tests.zip into memory 17:37:25 INFO - Content-Length response header: 14513823 17:37:25 INFO - Bytes received: 14513823 17:37:25 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')]} 17:37:25 INFO - trying https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2 17:37:25 INFO - Downloading https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:37:26 INFO - Downloaded 61658684 bytes. 17:37:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2 17:37:26 INFO - mkdir: /builds/slave/test/properties 17:37:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:37:26 INFO - Writing to file /builds/slave/test/properties/build_url 17:37:26 INFO - Contents: 17:37:26 INFO - build_url:https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2 17:37:26 INFO - Running post-action listener: _resource_record_post_action 17:37:26 INFO - Running post-action listener: find_tests_for_verification 17:37:26 INFO - Running post-action listener: set_extra_try_arguments 17:37:26 INFO - [mozharness: 2017-09-26 00:37:26.945220Z] Finished download-and-extract step (success) 17:37:26 INFO - [mozharness: 2017-09-26 00:37:26.945315Z] Running populate-webroot step. 17:37:26 INFO - Running pre-action listener: _resource_record_pre_action 17:37:26 INFO - Running main action method: populate_webroot 17:37:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:37:26 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:37:26 INFO - 'tests': ['tresize', 17:37:26 INFO - 'tcanvasmark']}, 17:37:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:37:26 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:37:26 INFO - 'tests': ['dromaeo_css', 17:37:26 INFO - 'kraken']}, 17:37:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:37:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:37:26 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:37:26 INFO - 'talos_options': ['--disable-stylo'], 17:37:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:37:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:37:26 INFO - 'tests': ['damp', 'tps']}, 17:37:26 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:37:26 INFO - 'talos_options': ['--disable-stylo'], 17:37:26 INFO - 'tests': ['damp', 'tps']}, 17:37:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:37:26 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:37:26 INFO - 'tests': ['dromaeo_dom']}, 17:37:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:37:26 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:37:26 INFO - 'tests': ['basic_compositor_video', 17:37:26 INFO - 'glvideo']}, 17:37:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:37:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:37:26 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:37:26 INFO - 'talos_options': ['--disable-stylo'], 17:37:26 INFO - 'tests': ['ts_paint_webext', 17:37:26 INFO - 'tp5o_webext']}, 17:37:26 INFO - 'other-e10s': {'tests': ['a11yr', 17:37:26 INFO - 'ts_paint', 17:37:26 INFO - 'tpaint', 17:37:26 INFO - 'sessionrestore', 17:37:26 INFO - 'sessionrestore_many_windows', 17:37:26 INFO - 'sessionrestore_no_auto_restore', 17:37:26 INFO - 'tabpaint']}, 17:37:26 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:37:26 INFO - 'tests': ['a11yr', 17:37:26 INFO - 'ts_paint', 17:37:26 INFO - 'tpaint', 17:37:26 INFO - 'sessionrestore', 17:37:26 INFO - 'sessionrestore_many_windows', 17:37:26 INFO - 'sessionrestore_no_auto_restore', 17:37:26 INFO - 'tabpaint']}, 17:37:26 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:37:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:37:26 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:37:26 INFO - 'tests': ['perf_reftest_singletons']}, 17:37:26 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:37:26 INFO - 'tests': ['perf_reftest']}, 17:37:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:37:26 INFO - 'tsvgr_opacity', 17:37:26 INFO - 'tart', 17:37:26 INFO - 'tscrollx', 17:37:26 INFO - 'tsvg_static']}, 17:37:26 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:37:26 INFO - 'tests': ['tsvgx', 17:37:26 INFO - 'tsvgr_opacity', 17:37:26 INFO - 'tart', 17:37:26 INFO - 'tscrollx', 17:37:26 INFO - 'tsvg_static']}, 17:37:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:37:26 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:37:26 INFO - 'talos_options': ['--disable-stylo'], 17:37:26 INFO - 'tests': ['tp5o']}, 17:37:26 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:37:26 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:37:26 INFO - 'talos_options': ['--mitmproxy', 17:37:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:37:26 INFO - '--firstNonBlankPaint'], 17:37:26 INFO - 'tests': ['tp6_google', 17:37:26 INFO - 'tp6_youtube', 17:37:26 INFO - 'tp6_amazon', 17:37:26 INFO - 'tp6_facebook']}, 17:37:26 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:37:26 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:37:26 INFO - 'talos_options': ['--disable-stylo', 17:37:26 INFO - '--mitmproxy', 17:37:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:37:26 INFO - '--firstNonBlankPaint'], 17:37:26 INFO - 'tests': ['tp6_google', 17:37:26 INFO - 'tp6_youtube', 17:37:26 INFO - 'tp6_amazon', 17:37:26 INFO - 'tp6_facebook']}, 17:37:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:37:26 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:37:26 INFO - 'talos_options': ['--stylo-threads=1', 17:37:26 INFO - '--mitmproxy', 17:37:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:37:26 INFO - '--firstNonBlankPaint'], 17:37:26 INFO - 'tests': ['tp6_google', 17:37:26 INFO - 'tp6_youtube', 17:37:26 INFO - 'tp6_amazon', 17:37:26 INFO - 'tp6_facebook']}, 17:37:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:37:26 INFO - 'talos_options': ['--xperf_path', 17:37:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:37:26 INFO - 'tests': ['tp5n']}, 17:37:26 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:37:26 INFO - 'talos_options': ['--disable-stylo', 17:37:26 INFO - '--xperf_path', 17:37:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:37:26 INFO - 'tests': ['tp5n']}}} 17:37:26 INFO - Running post-action listener: _resource_record_post_action 17:37:26 INFO - [mozharness: 2017-09-26 00:37:26.960625Z] Finished populate-webroot step (success) 17:37:26 INFO - [mozharness: 2017-09-26 00:37:26.960713Z] Running create-virtualenv step. 17:37:26 INFO - Running pre-action listener: _resource_record_pre_action 17:37:26 INFO - Running main action method: create_virtualenv 17:37:26 INFO - Creating virtualenv /builds/slave/test/build/venv 17:37:26 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:37:26 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:37:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:37:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:37:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:37:28 INFO - Installing distribute.............................................................................................................................................................................................done. 17:37:28 INFO - Installing pip...............done. 17:37:28 INFO - Return code: 0 17:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:37:28 INFO - Reading from file tmpfile_stdout 17:37:28 INFO - Output received: 17:37:28 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:37:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:37:28 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')]} 17:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:28 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')]} 17:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:28 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 0x13c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17339c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1730d60>, '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 0x1731a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', '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 17:37:28 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 17:37:28 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 17:37:28 INFO - Using env: {'DISPLAY': ':0', 17:37:28 INFO - 'HOME': '/home/cltbld', 17:37:28 INFO - 'LANG': 'en_US.UTF-8', 17:37:28 INFO - 'LANGUAGE': 'en_US:en', 17:37:28 INFO - 'LOGNAME': 'cltbld', 17:37:28 INFO - 'MAIL': '/var/mail/cltbld', 17:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:28 INFO - 'MOZ_NO_REMOTE': '1', 17:37:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:28 INFO - 'NO_EM_RESTART': '1', 17:37:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:28 INFO - 'PWD': '/builds/slave/test', 17:37:28 INFO - 'SHELL': '/bin/bash', 17:37:28 INFO - 'SHLVL': '1', 17:37:28 INFO - 'TERM': 'linux', 17:37:28 INFO - 'TMOUT': '86400', 17:37:28 INFO - 'USER': 'cltbld', 17:37:28 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:28 INFO - '_': '/tools/buildbot/bin/python'} 17:37:29 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:37:29 INFO - Downloading/unpacking pip>=1.5 17:37:29 INFO - Running setup.py egg_info for package pip 17:37:29 INFO - warning: no files found matching 'pip/cacert.pem' 17:37:29 INFO - warning: no files found matching '*.html' under directory 'docs' 17:37:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:37:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:37:29 INFO - Installing collected packages: pip 17:37:29 INFO - Found existing installation: pip 1.1 17:37:29 INFO - Uninstalling pip: 17:37:29 INFO - Successfully uninstalled pip 17:37:29 INFO - Running setup.py install for pip 17:37:29 INFO - warning: no files found matching 'pip/cacert.pem' 17:37:29 INFO - warning: no files found matching '*.html' under directory 'docs' 17:37:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:37:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:37:29 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:37:29 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:37:29 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:37:29 INFO - Successfully installed pip 17:37:29 INFO - Cleaning up... 17:37:29 INFO - Return code: 0 17:37:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:37:29 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')]} 17:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:29 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')]} 17:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:29 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 0x13c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17339c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1730d60>, '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 0x1731a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', '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 17:37:29 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 17:37:29 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 17:37:29 INFO - Using env: {'DISPLAY': ':0', 17:37:29 INFO - 'HOME': '/home/cltbld', 17:37:29 INFO - 'LANG': 'en_US.UTF-8', 17:37:29 INFO - 'LANGUAGE': 'en_US:en', 17:37:29 INFO - 'LOGNAME': 'cltbld', 17:37:29 INFO - 'MAIL': '/var/mail/cltbld', 17:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:29 INFO - 'MOZ_NO_REMOTE': '1', 17:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:29 INFO - 'NO_EM_RESTART': '1', 17:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:29 INFO - 'PWD': '/builds/slave/test', 17:37:29 INFO - 'SHELL': '/bin/bash', 17:37:29 INFO - 'SHLVL': '1', 17:37:29 INFO - 'TERM': 'linux', 17:37:29 INFO - 'TMOUT': '86400', 17:37:29 INFO - 'USER': 'cltbld', 17:37:29 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:29 INFO - '_': '/tools/buildbot/bin/python'} 17:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:30 INFO - Downloading/unpacking psutil>=3.1.1 17:37:30 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 17:37:30 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 17:37:30 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 17:37:30 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 17:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:37:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:37:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:37:31 INFO - Installing collected packages: psutil 17:37:31 INFO - Running setup.py install for psutil 17:37:31 INFO - building 'psutil._psutil_linux' extension 17:37:31 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 17:37:33 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 17:37:33 INFO - building 'psutil._psutil_posix' extension 17:37:33 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 17:37:33 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 17:37:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:37:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:37:33 INFO - Successfully installed psutil 17:37:33 INFO - Cleaning up... 17:37:33 INFO - Return code: 0 17:37:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:37:33 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')]} 17:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:33 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')]} 17:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:33 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 0x13c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17339c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1730d60>, '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 0x1731a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', '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 17:37:33 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 17:37:33 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 17:37:33 INFO - Using env: {'DISPLAY': ':0', 17:37:33 INFO - 'HOME': '/home/cltbld', 17:37:33 INFO - 'LANG': 'en_US.UTF-8', 17:37:33 INFO - 'LANGUAGE': 'en_US:en', 17:37:33 INFO - 'LOGNAME': 'cltbld', 17:37:33 INFO - 'MAIL': '/var/mail/cltbld', 17:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:33 INFO - 'MOZ_NO_REMOTE': '1', 17:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:33 INFO - 'NO_EM_RESTART': '1', 17:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:33 INFO - 'PWD': '/builds/slave/test', 17:37:33 INFO - 'SHELL': '/bin/bash', 17:37:33 INFO - 'SHLVL': '1', 17:37:33 INFO - 'TERM': 'linux', 17:37:33 INFO - 'TMOUT': '86400', 17:37:33 INFO - 'USER': 'cltbld', 17:37:33 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:33 INFO - '_': '/tools/buildbot/bin/python'} 17:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:37:33 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 17:37:33 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 17:37:33 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 17:37:33 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 17:37:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:37:34 INFO - Installing collected packages: mozsystemmonitor 17:37:34 INFO - Running setup.py install for mozsystemmonitor 17:37:35 INFO - Successfully installed mozsystemmonitor 17:37:35 INFO - Cleaning up... 17:37:35 INFO - Return code: 0 17:37:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17339c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1730d60>, '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 0x1731a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', '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 17:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:37:35 INFO - Using env: {'DISPLAY': ':0', 17:37:35 INFO - 'HOME': '/home/cltbld', 17:37:35 INFO - 'LANG': 'en_US.UTF-8', 17:37:35 INFO - 'LANGUAGE': 'en_US:en', 17:37:35 INFO - 'LOGNAME': 'cltbld', 17:37:35 INFO - 'MAIL': '/var/mail/cltbld', 17:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:35 INFO - 'MOZ_NO_REMOTE': '1', 17:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:35 INFO - 'NO_EM_RESTART': '1', 17:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:35 INFO - 'PWD': '/builds/slave/test', 17:37:35 INFO - 'SHELL': '/bin/bash', 17:37:35 INFO - 'SHLVL': '1', 17:37:35 INFO - 'TERM': 'linux', 17:37:35 INFO - 'TMOUT': '86400', 17:37:35 INFO - 'USER': 'cltbld', 17:37:35 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:35 INFO - '_': '/tools/buildbot/bin/python'} 17:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:35 INFO - Downloading/unpacking jsonschema==2.5.1 17:37:35 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 17:37:35 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 17:37:35 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 17:37:35 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 17:37:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:37:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:36 INFO - Downloading functools32-3.2.3-2.tar.gz 17:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:37:36 INFO - warning: no files found matching '*.txt' 17:37:36 INFO - no previously-included directories found matching 'build' 17:37:36 INFO - no previously-included directories found matching 'dist' 17:37:36 INFO - no previously-included directories found matching '.git*' 17:37:36 INFO - Installing collected packages: jsonschema, functools32 17:37:36 INFO - Running setup.py install for functools32 17:37:36 INFO - warning: no files found matching '*.txt' 17:37:36 INFO - no previously-included directories found matching 'build' 17:37:36 INFO - no previously-included directories found matching 'dist' 17:37:36 INFO - no previously-included directories found matching '.git*' 17:37:36 INFO - Successfully installed jsonschema functools32 17:37:36 INFO - Cleaning up... 17:37:36 INFO - Return code: 0 17:37:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17339c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1730d60>, '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 0x1731a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', '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 17:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:37:36 INFO - Using env: {'DISPLAY': ':0', 17:37:36 INFO - 'HOME': '/home/cltbld', 17:37:36 INFO - 'LANG': 'en_US.UTF-8', 17:37:36 INFO - 'LANGUAGE': 'en_US:en', 17:37:36 INFO - 'LOGNAME': 'cltbld', 17:37:36 INFO - 'MAIL': '/var/mail/cltbld', 17:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:36 INFO - 'MOZ_NO_REMOTE': '1', 17:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:36 INFO - 'NO_EM_RESTART': '1', 17:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:36 INFO - 'PWD': '/builds/slave/test', 17:37:36 INFO - 'SHELL': '/bin/bash', 17:37:36 INFO - 'SHLVL': '1', 17:37:36 INFO - 'TERM': 'linux', 17:37:36 INFO - 'TMOUT': '86400', 17:37:36 INFO - 'USER': 'cltbld', 17:37:36 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:36 INFO - '_': '/tools/buildbot/bin/python'} 17:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:37:36 INFO - Cleaning up... 17:37:37 INFO - Return code: 0 17:37:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:37:37 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')]} 17:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:37 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')]} 17:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:37 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 0x13c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17339c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1730d60>, '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 0x1731a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', '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 17:37:37 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 17:37:37 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 17:37:37 INFO - Using env: {'DISPLAY': ':0', 17:37:37 INFO - 'HOME': '/home/cltbld', 17:37:37 INFO - 'LANG': 'en_US.UTF-8', 17:37:37 INFO - 'LANGUAGE': 'en_US:en', 17:37:37 INFO - 'LOGNAME': 'cltbld', 17:37:37 INFO - 'MAIL': '/var/mail/cltbld', 17:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:37 INFO - 'MOZ_NO_REMOTE': '1', 17:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:37 INFO - 'NO_EM_RESTART': '1', 17:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:37 INFO - 'PWD': '/builds/slave/test', 17:37:37 INFO - 'SHELL': '/bin/bash', 17:37:37 INFO - 'SHLVL': '1', 17:37:37 INFO - 'TERM': 'linux', 17:37:37 INFO - 'TMOUT': '86400', 17:37:37 INFO - 'USER': 'cltbld', 17:37:37 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:37 INFO - '_': '/tools/buildbot/bin/python'} 17:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:37 INFO - Downloading/unpacking blobuploader==1.2.4 17:37:37 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 17:37:37 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 17:37:37 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 17:37:37 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 17:37:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:37:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:37:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:38 INFO - Downloading docopt-0.6.1.tar.gz 17:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:37:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:37:38 INFO - Running setup.py install for blobuploader 17:37:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:37:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:37:39 INFO - Running setup.py install for requests 17:37:39 INFO - Running setup.py install for docopt 17:37:39 INFO - Successfully installed blobuploader requests docopt 17:37:39 INFO - Cleaning up... 17:37:40 INFO - Return code: 0 17:37:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37: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')]} 17:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:40 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 0x13c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17339c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1730d60>, '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 0x1731a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', '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 17:37:40 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 17:37:40 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 17:37:40 INFO - Using env: {'DISPLAY': ':0', 17:37:40 INFO - 'HOME': '/home/cltbld', 17:37:40 INFO - 'LANG': 'en_US.UTF-8', 17:37:40 INFO - 'LANGUAGE': 'en_US:en', 17:37:40 INFO - 'LOGNAME': 'cltbld', 17:37:40 INFO - 'MAIL': '/var/mail/cltbld', 17:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:40 INFO - 'MOZ_NO_REMOTE': '1', 17:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:40 INFO - 'NO_EM_RESTART': '1', 17:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:40 INFO - 'PWD': '/builds/slave/test', 17:37:40 INFO - 'SHELL': '/bin/bash', 17:37:40 INFO - 'SHLVL': '1', 17:37:40 INFO - 'TERM': 'linux', 17:37:40 INFO - 'TMOUT': '86400', 17:37:40 INFO - 'USER': 'cltbld', 17:37:40 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:40 INFO - '_': '/tools/buildbot/bin/python'} 17:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:37:40 INFO - Running setup.py (path:/tmp/pip-g80wN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:37:40 INFO - Running setup.py (path:/tmp/pip-S0ICwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:37:40 INFO - Running setup.py (path:/tmp/pip-iFSqPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:37:40 INFO - Running setup.py (path:/tmp/pip-vIjIya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:37:40 INFO - Running setup.py (path:/tmp/pip-rFLcOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:37:40 INFO - Running setup.py (path:/tmp/pip-xctzj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:37:41 INFO - Running setup.py (path:/tmp/pip-CxMM6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:37:41 INFO - Running setup.py (path:/tmp/pip-3F4r9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:37:41 INFO - Running setup.py (path:/tmp/pip-jMPB4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:37:41 INFO - Running setup.py (path:/tmp/pip-SzqAJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:37:41 INFO - Running setup.py (path:/tmp/pip-3mTeDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:37:41 INFO - Running setup.py (path:/tmp/pip-xNojYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:37:41 INFO - Running setup.py (path:/tmp/pip-oiUerS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:37:41 INFO - Running setup.py (path:/tmp/pip-GFrupL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:41 INFO - Running setup.py (path:/tmp/pip-X1uJCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:37:41 INFO - Running setup.py (path:/tmp/pip-MLktTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:37:41 INFO - Running setup.py (path:/tmp/pip-zxmS9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:37:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:37:41 INFO - Running setup.py install for manifestparser 17:37:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:37:41 INFO - Running setup.py install for mozcrash 17:37:41 INFO - Running setup.py install for mozdebug 17:37:42 INFO - Running setup.py install for mozdevice 17:37:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:37:42 INFO - Running setup.py install for mozfile 17:37:42 INFO - Running setup.py install for mozhttpd 17:37:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:37:42 INFO - Running setup.py install for mozinfo 17:37:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:37:42 INFO - Running setup.py install for mozInstall 17:37:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:37:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:37:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:37:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:37:42 INFO - Running setup.py install for mozleak 17:37:42 INFO - Running setup.py install for mozlog 17:37:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:37:42 INFO - Running setup.py install for moznetwork 17:37:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:37:42 INFO - Running setup.py install for mozprocess 17:37:42 INFO - Running setup.py install for mozprofile 17:37:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:37:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:37:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:37:43 INFO - Running setup.py install for mozrunner 17:37:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:37:43 INFO - Running setup.py install for mozscreenshot 17:37:43 INFO - Running setup.py install for moztest 17:37:43 INFO - Running setup.py install for mozversion 17:37:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:37:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:37:43 INFO - Cleaning up... 17:37:43 INFO - Return code: 0 17:37:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:43 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 0x13c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17339c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1730d60>, '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 0x1731a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', '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 17:37:43 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 17:37:43 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 17:37:43 INFO - Using env: {'DISPLAY': ':0', 17:37:43 INFO - 'HOME': '/home/cltbld', 17:37:43 INFO - 'LANG': 'en_US.UTF-8', 17:37:43 INFO - 'LANGUAGE': 'en_US:en', 17:37:43 INFO - 'LOGNAME': 'cltbld', 17:37:43 INFO - 'MAIL': '/var/mail/cltbld', 17:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:43 INFO - 'MOZ_NO_REMOTE': '1', 17:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:43 INFO - 'NO_EM_RESTART': '1', 17:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:43 INFO - 'PWD': '/builds/slave/test', 17:37:43 INFO - 'SHELL': '/bin/bash', 17:37:43 INFO - 'SHLVL': '1', 17:37:43 INFO - 'TERM': 'linux', 17:37:43 INFO - 'TMOUT': '86400', 17:37:43 INFO - 'USER': 'cltbld', 17:37:43 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:43 INFO - '_': '/tools/buildbot/bin/python'} 17:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:37:43 INFO - Running setup.py (path:/tmp/pip-BKanda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:37:43 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)) 17:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:37:43 INFO - Running setup.py (path:/tmp/pip-w9sN77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:37:43 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)) 17:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:37:43 INFO - Running setup.py (path:/tmp/pip-H8AxXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:37:43 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)) 17:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:37:43 INFO - Running setup.py (path:/tmp/pip-gJaMON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:37:43 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)) 17:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:37:43 INFO - Running setup.py (path:/tmp/pip-wSTMux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:37:43 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)) 17:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:37:43 INFO - Running setup.py (path:/tmp/pip-ndUzBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:37:44 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)) 17:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:37:44 INFO - Running setup.py (path:/tmp/pip-jB_08z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:37:44 INFO - Running setup.py (path:/tmp/pip-sMaEXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:37:44 INFO - Running setup.py (path:/tmp/pip-FNTKqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:37:44 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)) 17:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:37:44 INFO - Running setup.py (path:/tmp/pip-MLtSFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 17:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:37:44 INFO - Running setup.py (path:/tmp/pip-CB2A5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:37:44 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)) 17:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:37:44 INFO - Running setup.py (path:/tmp/pip-nDNW5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:37:44 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)) 17:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:37:44 INFO - Running setup.py (path:/tmp/pip-BsmRdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:37:44 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)) 17:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:37:44 INFO - Running setup.py (path:/tmp/pip-_Z6iaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:37:44 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)) 17:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:44 INFO - Running setup.py (path:/tmp/pip-HFr815-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:44 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)) 17:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:37:44 INFO - Running setup.py (path:/tmp/pip-iYA6Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:37:44 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)) 17:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:37:44 INFO - Running setup.py (path:/tmp/pip-otjOKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:37:44 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)) 17:37:44 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)) 17:37:44 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)) 17:37:44 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)) 17:37:44 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)) 17:37:44 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)) 17:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:37:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:45 INFO - Downloading blessings-1.6.tar.gz 17:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:37:46 INFO - Installing collected packages: blessings 17:37:46 INFO - Running setup.py install for blessings 17:37:46 INFO - Successfully installed blessings 17:37:46 INFO - Cleaning up... 17:37:46 INFO - Return code: 0 17:37:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:37:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:46 INFO - Reading from file tmpfile_stdout 17:37:46 INFO - Current package versions: 17:37:46 INFO - argparse == 1.2.1 17:37:46 INFO - blessings == 1.6 17:37:46 INFO - blobuploader == 1.2.4 17:37:46 INFO - docopt == 0.6.1 17:37:46 INFO - functools32 == 3.2.3-2 17:37:46 INFO - jsonschema == 2.5.1 17:37:46 INFO - manifestparser == 1.1 17:37:46 INFO - mozInstall == 1.13 17:37:46 INFO - mozcrash == 1.0 17:37:46 INFO - mozdebug == 0.1 17:37:46 INFO - mozdevice == 0.51 17:37:46 INFO - mozfile == 1.2 17:37:46 INFO - mozhttpd == 0.7 17:37:46 INFO - mozinfo == 0.10 17:37:46 INFO - mozleak == 0.1 17:37:46 INFO - mozlog == 3.5 17:37:46 INFO - moznetwork == 0.27 17:37:46 INFO - mozprocess == 0.25 17:37:46 INFO - mozprofile == 0.28 17:37:46 INFO - mozrunner == 6.13 17:37:46 INFO - mozscreenshot == 0.1 17:37:46 INFO - mozsystemmonitor == 0.3 17:37:46 INFO - moztest == 0.8 17:37:46 INFO - mozversion == 1.4 17:37:46 INFO - psutil == 3.1.1 17:37:46 INFO - requests == 1.2.3 17:37:46 INFO - wsgiref == 0.1.2 17:37:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:46 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 0x13c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17339c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1730d60>, '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 0x1731a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', '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 17:37:46 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 17:37:46 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 17:37:46 INFO - Using env: {'DISPLAY': ':0', 17:37:46 INFO - 'HOME': '/home/cltbld', 17:37:46 INFO - 'LANG': 'en_US.UTF-8', 17:37:46 INFO - 'LANGUAGE': 'en_US:en', 17:37:46 INFO - 'LOGNAME': 'cltbld', 17:37:46 INFO - 'MAIL': '/var/mail/cltbld', 17:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:46 INFO - 'MOZ_NO_REMOTE': '1', 17:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:46 INFO - 'NO_EM_RESTART': '1', 17:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:46 INFO - 'PWD': '/builds/slave/test', 17:37:46 INFO - 'SHELL': '/bin/bash', 17:37:46 INFO - 'SHLVL': '1', 17:37:46 INFO - 'TERM': 'linux', 17:37:46 INFO - 'TMOUT': '86400', 17:37:46 INFO - 'USER': 'cltbld', 17:37:46 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:46 INFO - '_': '/tools/buildbot/bin/python'} 17:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:46 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)) 17:37:46 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)) 17:37:46 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)) 17:37:46 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)) 17:37:46 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)) 17:37:46 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)) 17:37:46 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)) 17:37:46 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)) 17:37:46 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)) 17:37:46 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:37:48 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)) 17:37:48 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)) 17:37:48 INFO - Installing collected packages: simplejson 17:37:48 INFO - Running setup.py install for simplejson 17:37:48 INFO - building 'simplejson._speedups' extension 17:37:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 17:37:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:37:49 INFO - Successfully installed simplejson 17:37:49 INFO - Cleaning up... 17:37:49 INFO - Return code: 0 17:37:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37: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')]} 17:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17339c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1730d60>, '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 0x1731a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731ef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', '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 17:37: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'] in /builds/slave/test/build 17:37: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 17:37:49 INFO - Using env: {'DISPLAY': ':0', 17:37:49 INFO - 'HOME': '/home/cltbld', 17:37:49 INFO - 'LANG': 'en_US.UTF-8', 17:37:49 INFO - 'LANGUAGE': 'en_US:en', 17:37:49 INFO - 'LOGNAME': 'cltbld', 17:37:49 INFO - 'MAIL': '/var/mail/cltbld', 17:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:49 INFO - 'MOZ_NO_REMOTE': '1', 17:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:49 INFO - 'NO_EM_RESTART': '1', 17:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:49 INFO - 'PWD': '/builds/slave/test', 17:37:49 INFO - 'SHELL': '/bin/bash', 17:37:49 INFO - 'SHLVL': '1', 17:37:49 INFO - 'TERM': 'linux', 17:37:49 INFO - 'TMOUT': '86400', 17:37:49 INFO - 'USER': 'cltbld', 17:37:49 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:49 INFO - '_': '/tools/buildbot/bin/python'} 17:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:37:49 INFO - Cleaning up... 17:37:49 INFO - Return code: 0 17:37:49 INFO - Running post-action listener: _resource_record_post_action 17:37:49 INFO - Running post-action listener: _start_resource_monitoring 17:37:49 INFO - Starting resource monitoring. 17:37:49 INFO - [mozharness: 2017-09-26 00:37:49.300753Z] Finished create-virtualenv step (success) 17:37:49 INFO - [mozharness: 2017-09-26 00:37:49.301699Z] Running install step. 17:37:49 INFO - Running pre-action listener: _resource_record_pre_action 17:37:49 INFO - Running main action method: install 17:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:49 INFO - Reading from file tmpfile_stdout 17:37:49 INFO - Detecting whether we're running mozinstall >=1.0... 17:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:37:49 INFO - Reading from file tmpfile_stdout 17:37:49 INFO - Output received: 17:37:49 INFO - Usage: mozinstall [options] installer 17:37:49 INFO - Options: 17:37:49 INFO - -h, --help show this help message and exit 17:37:49 INFO - -d DEST, --destination=DEST 17:37:49 INFO - Directory to install application into. [default: 17:37:49 INFO - "/builds/slave/test"] 17:37:49 INFO - --app=APP Application being installed. [default: firefox] 17:37:49 INFO - mkdir: /builds/slave/test/build/application 17:37:49 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'] 17:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:38:07 INFO - Reading from file tmpfile_stdout 17:38:07 INFO - Output received: 17:38:07 INFO - /builds/slave/test/build/application/firefox/firefox 17:38:07 INFO - Running post-action listener: _resource_record_post_action 17:38:07 INFO - [mozharness: 2017-09-26 00:38:07.494957Z] Finished install step (success) 17:38:07 INFO - [mozharness: 2017-09-26 00:38:07.495102Z] Running setup-mitmproxy step. 17:38:07 INFO - Running pre-action listener: _resource_record_pre_action 17:38:07 INFO - Running main action method: setup_mitmproxy 17:38:07 INFO - Skipping: mitmproxy is not required 17:38:07 INFO - Running post-action listener: _resource_record_post_action 17:38:07 INFO - [mozharness: 2017-09-26 00:38:07.495670Z] Finished setup-mitmproxy step (success) 17:38:07 INFO - [mozharness: 2017-09-26 00:38:07.495915Z] Running run-tests step. 17:38:07 INFO - Running pre-action listener: _resource_record_pre_action 17:38:07 INFO - Running pre-action listener: _set_gcov_prefix 17:38:07 INFO - Running main action method: run_tests 17:38:07 WARNING - Try message not found. 17:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:38:07 INFO - Python 2.7.3 17:38:07 INFO - Return code: 0 17:38:07 INFO - grabbing minidump binary from tooltool 17:38:07 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')]} 17:38:07 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x1730d60>, '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 0x1731a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:38:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 17:38:07 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:38:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 17:38:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:38:07 INFO - Return code: 0 17:38:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:38:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:38:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:38:07 INFO - ENV: RUST_BACKTRACE is now full 17:38:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:38:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:38:07 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 17:38:07 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-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 17:38:07 INFO - Using env: {'DISPLAY': ':0', 17:38:07 INFO - 'HOME': '/home/cltbld', 17:38:07 INFO - 'LANG': 'en_US.UTF-8', 17:38:07 INFO - 'LANGUAGE': 'en_US:en', 17:38:07 INFO - 'LOGNAME': 'cltbld', 17:38:07 INFO - 'MAIL': '/var/mail/cltbld', 17:38:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:38:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:07 INFO - 'MOZ_NO_REMOTE': '1', 17:38:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:07 INFO - 'NO_EM_RESTART': '1', 17:38:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:07 INFO - 'PWD': '/builds/slave/test', 17:38:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:38:07 INFO - 'RUST_BACKTRACE': 'full', 17:38:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:38:07 INFO - 'SHELL': '/bin/bash', 17:38:07 INFO - 'SHLVL': '1', 17:38:07 INFO - 'TERM': 'linux', 17:38:07 INFO - 'TMOUT': '86400', 17:38:07 INFO - 'USER': 'cltbld', 17:38:07 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:07 INFO - '_': '/tools/buildbot/bin/python'} 17:38:07 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 17:38:08 INFO - mozversion application_buildid: 20170925234146 17:38:08 INFO - mozversion application_changeset: e6b3498a39b94616ba36798fe0b71a3090b1b14c 17:38:08 INFO - mozversion application_display_name: Nightly 17:38:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:38:08 INFO - mozversion application_name: Firefox 17:38:08 INFO - mozversion application_remotingname: firefox 17:38:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:38:08 INFO - mozversion application_vendor: Mozilla 17:38:08 INFO - mozversion application_version: 58.0a1 17:38:08 INFO - mozversion platform_buildid: 20170925234146 17:38:08 INFO - mozversion platform_changeset: e6b3498a39b94616ba36798fe0b71a3090b1b14c 17:38:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:38:08 INFO - mozversion platform_version: 58.0a1 17:38:08 INFO - using testdate: 1506386288 17:38:08 INFO - actual date: 1506386288 17:38:08 INFO - starting webserver on 'localhost:48550' 17:38:08 INFO - SUITE-START | Running 2 tests 17:38:08 INFO - TEST-START | dromaeo_css 17:38:08 INFO - Initialising browser for dromaeo_css test... 17:38:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48550/getInfo.html -profile /tmp/tmpcrWSA_/profile 17:38:08 INFO - TEST-INFO | started process 3554 (/builds/slave/test/build/application/firefox/firefox http://localhost:48550/getInfo.html) 17:38:17 INFO - TEST-INFO | 3554: exit 0 17:38:17 INFO - Browser initialized. 17:38:17 INFO - Running cycle 1/1 for dromaeo_css test... 17:38:17 INFO - Using env: {'DISPLAY': ':0', 17:38:17 INFO - 'HOME': '/home/cltbld', 17:38:17 INFO - 'JSGC_DISABLE_POISONING': '1', 17:38:17 INFO - 'LANG': 'en_US.UTF-8', 17:38:17 INFO - 'LANGUAGE': 'en_US:en', 17:38:17 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:38:17 INFO - 'LOGNAME': 'cltbld', 17:38:17 INFO - 'MAIL': '/var/mail/cltbld', 17:38:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:38:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:38:17 INFO - 'MOZ_CRASHREPORTER': '1', 17:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:17 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:38:17 INFO - 'MOZ_NO_REMOTE': '1', 17:38:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:17 INFO - 'NO_EM_RESTART': '1', 17:38:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:17 INFO - 'PWD': '/builds/slave/test', 17:38:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:38:17 INFO - 'RUST_BACKTRACE': 'full', 17:38:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:38:17 INFO - 'SHELL': '/bin/bash', 17:38:17 INFO - 'SHLVL': '1', 17:38:17 INFO - 'STYLO_FORCE_DISABLED': '1', 17:38:17 INFO - 'TERM': 'linux', 17:38:17 INFO - 'TMOUT': '86400', 17:38:17 INFO - 'USER': 'cltbld', 17:38:17 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:17 INFO - '_': '/tools/buildbot/bin/python'} 17:38:17 INFO - TEST-INFO | started process 3793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcrWSA_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:38:18 INFO - PID 3793 | 17:38:18 INFO - PID 3793 | (/builds/slave/test/build/application/firefox/firefox:3842): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:38:18 INFO - PID 3793 | 17:38:28 INFO - PID 3793 | RSS: Main: 147857408 17:38:28 INFO - PID 3793 | 17:41:24 INFO - PID 3793 | Cycle 1(1): loaded http://localhost:48550/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48550/tests/dromaeo/cssquery-ext.html) 17:41:26 INFO - PID 3793 | RSS: Main: 152408064 17:41:26 INFO - PID 3793 | 17:44:27 INFO - PID 3793 | Cycle 1(1): loaded http://localhost:48550/tests/dromaeo/cssquery-ext.html (next: http://localhost:48550/tests/dromaeo/cssquery-jquery.html) 17:44:28 INFO - PID 3793 | RSS: Main: 152436736 17:44:28 INFO - PID 3793 | 17:47:30 INFO - PID 3793 | Cycle 1(1): loaded http://localhost:48550/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48550/tests/dromaeo/cssquery-mootools.html) 17:47:30 INFO - PID 3793 | RSS: Main: 154333184 17:47:30 INFO - PID 3793 | 17:50:32 INFO - PID 3793 | Cycle 1(1): loaded http://localhost:48550/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48550/tests/dromaeo/cssquery-prototype.html) 17:50:33 INFO - PID 3793 | RSS: Main: 152801280 17:50:33 INFO - PID 3793 | 17:53:36 INFO - PID 3793 | Cycle 1(1): loaded http://localhost:48550/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48550/tests/dromaeo/cssquery-yui.html) 17:53:37 INFO - PID 3793 | RSS: Main: 154234880 17:53:37 INFO - PID 3793 | 17:56:38 INFO - PID 3793 | Cycle 1(1): loaded http://localhost:48550/tests/dromaeo/cssquery-yui.html (next: http://localhost:48550/tests/dromaeo/cssquery-dojo.html) 17:56:38 INFO - PID 3793 | RSS: Main: 156250112 17:56:38 INFO - PID 3793 | 17:56:38 INFO - PID 3793 | __start_tp_report 17:56:38 INFO - PID 3793 | _x_x_mozilla_page_load 17:56:38 INFO - PID 3793 | _x_x_mozilla_page_load_details 17:56:38 INFO - PID 3793 | |i|pagename|runs| 17:56:38 INFO - PID 3793 | |0;dojo.html;3082.676318986505;3083.4449799036165;3088.197068762122;3094.180042288793;3097.0553981035773;6025;6043.728032238549;6130.877382452349;6167.167432396625;6212.409821066997;6112;6125.387461253872;6139.4167554082405;6160.168377269068;6263.3423490533405;5799.594028418012;5832.300123985117;5837.532997360222;5861.120831875211;5872.060470324749;30.823612583951927;5801.680907550083;5868.2371291732225;5894.821035792858;5895.027320492114;5664.886702265972;5693.544516438675;5719.971400143014;5817.912731309034;5822.272215973004;5696.857578560528;5767.942320576783;5801.245838041028;5823.388544202882;5833.620814647034;5681.715914204273;5695.288088988877;5751.942480575182;5799.768009279624;5801.390853960315;6123.846903827395;6166.691665416756;6224.502039836802;6304.117423560705;6314.400131987454;6505.414512693833;6584.967075164594;6598.670066496656;6684.866302673968;6690.397864192198;6623.337666233387;6627.271000189975;6637.535372523926;6665.200175978865;6671.199456065255;6038.63768173911;6132.662703551303;6202.782902598433;6243.063540468921;6324;6871.312868713188;6897.48268879836;6956.026156338066;6960.269171736996;6960.686769095403;6558.508111891627;6586.8353291168105;6630.83422914431;6656.36764507371;6695.363940425652;6446.806595802133;6566.507511936624;6627.86744265112;6695.698693558801;6706;6597.670116494156;6663.933360666331;6683.997400389981;6711.530192886548;6715.6977935993;6593.736250549924;6665.900011499832;6686.665666716644;6750.291219421988;6762;5147.279380886679;5253.632245742761;5256.448072952285;5265.7103859287345;5270.814066835008;4550.431196100488;4573.085382923362;4573.405457290531;4580.58774710271;4583.633309335245;5598;5604.075327570987;5607.7476513556985;5614.775408983595;5632.04255276604;6535.215774107138;6622.933770662328;6629.602223866584;6630.933690663128;6708.563943343667;5733.111367738007;5745.454181852718;5763.88472230553;5783.624064435799;5791.102379131242;5729.054705973551;5737.827865164052;5815.214945982323;5828.76684932598;5836.649801011953;6295;6373.235211774524;6452.161219041494;6465.515086368541;6548.738050478023;6691.26396096429;6726.831829204211;6732.057511948233;6735.326467353323;6749.865002700017;6413.4869210463985;6450.41946224842;6493;6515.54391192612;6553.4101930826455;6407.775727849503;6542.295923403378;6553.2136143663065;6634.03806448072;6662.300458451793;6602.867942641216;6628.403443690091;6665.600063996176;6672.4328432081875;6682.031105489774;6475.061116138228;6526.184226971629;6545.312742162005;6545.574537655038;6545.770898018546;6443.935560644333;6485.902711459426;6544.9672751635935;6545.574537655038;6546.607203567801;6362.713677884413;6363.840903977438;6392.3927226913365;6444.065610486547;6449.12936753551;6320.08358787964;6507.511936604868;6536.7712130075215;6600.669966501751;6609.041688954979;6364.427201551883;6364.745410183541;6377.96811015942;6391.296957334783;6410.583312084699 17:56:38 INFO - PID 3793 | |1;ext.html;791.4420333664767;791.8495485857686;810.9107998120206;834.58687949465;837.3385025829594;41101.3834792478;41868;41877.58122418775;42006.36990445142;42052.158956820844;37659;41660.37509437361;42500.57499425005;42582.57417425825;42621;7605.543667379961;7730;7742.380609551251;7743.922560774405;7748.573828439462;7558.848823023563;7633.809154771147;7639.885401718979;7662.885056724126;7677.270659287359;7670.846583068335;7710.653020614086;7714;7714.421418393615;7752.341051010642;7616.581088040156;7656.770296891074;7660.616969151548;7698.384129269701;7699.4995325304235;7486.737964171282;7552.848943021108;7554.169041405441;7558.773236802905;7571.280728330799;38044.04889877747;38239;38312.23375532502;38335.61664383376;38366;3520.489529018278;3534.5228394166716;3553.928921421583;3562.6259242779392;3563.964360356389;30973.535396969062;31177;31232;31265.687343126505;31347.216319592193;4765.332853400527;4915.803367865281;4922.286268491084;4938.259261110827;4953.702777833341;184584;184870;185669;185778;186621;47005.529944700116;47128.5287147131;47136.29295560569;47176.05647887023;47377.28934065992;49019.75490122598;49237.261441078415;49307.50692493029;49412.50587494151;49487;13907;14173.858261417254;14256.714865702836;14267.64330891736;14270.072445291024;11288.0969522438;11293.209475336811;11340.716482088013;11359.148063895242;11411.201215914973;13005.21968681882;13292.468301268034;13311.935045196555;13312.400941957636;13319.669057914825;5110.616703747234;5128.487151284841;5151.665141765773;5176.171812509981;5215.24378965048;1004.4224570871778;1019.7654539455966;1027.4554486122368;1032.5405194688442;1048.580567772897;22594.322170334915;23136.884315578314;23139.88430057839;23160.884195578914;23251.88374058119;1094.6223552874246;1117.474786850179;1122.3322123336602;1138.260130914912;1147.2772153543215;11974.127812601315;12292.385380730928;12356.752864942651;12367.93816030932;12395.380230988414;225923;227003;227774;228238;228299;53535.46464535383;58277.417225828045;58326;58587.70706146527;58688;1458.3364569121024;1490.7763835424555;1501.7371959906973;1505.9774103388238;1508.7963124978207;26797.598036029085;27230.455390892468;27481.725182747916;27528.862355688092;27815.721842781313;38102.61897381102;38448.23103537969;38488.037799055244;38516.80741596274;38531.6146838528;146243;146518;146666.26666866598;146916;146924.26537867243;36396.636033639326;36480;36537;36617;36919.26161476702;41464.79267603643;42850.57149428466;42928;43171.78414107909;43800.78099609609;31513.52729709102;31713.5242971351;32101.678983210804;32131;32191.195220119684;31508.36983260368;31558.211044724067;31700.207494812814;31923.84038079795;31932;35603.465948010286;35847.283054338244;35895;36192;36299.81850090733;30117;30316.24209394783;30648;30982.69017309798;31080;22271.6214663581;22757.203497877494;22866.08535658555;23125.88437057804;23128.76871231266 17:56:38 INFO - PID 3793 | |2;jquery.html;601.0473399661536;602.6022824935542;605.4369436424126;614.8217017065051;619.2135987296133;21857.453563660918;22534.323970280875;22547.098116075358;22560.323190304276;22584.43538911526;23026.424339391524;24245.151419700313;24350;24439.144629937957;24475.75524244757;6169.074638804182;6363.8409039773915;6365.809025729212;6370.203724534434;6372.458341040994;6214.8135555933395;6314.905276420857;6592.736290548372;6800.659967001655;6876.071730316418;6805.149356330458;6808.659567021654;6821.863562728742;6837.623930683811;6837.965810170942;6776.898346524806;6817.250102488747;6822.4200942919415;6828.214755303154;6844.38400543951;6631.568948018364;6634.170728658918;6676.232233293184;6686.364795344434;6715.059891615178;27787.16638500848;29257.268568285752;29731.256718582208;30020.699793002226;30037.249068773235;2057.177129148338;2073.429806803126;2092.2677063027973;2094.9057292421726;2101.0020240385848;19787.40637780869;19926.60146797056;20874.686879696816;20896.164153433845;20896.895515522327;2296.2422400607925;2305.8385912986096;2374.691290132289;2379.785819276256;2381.20229723043;126342;129437.35281323627;145932;150125;150475.9999999989;20094.296699615737;21173;21651.891740541196;22027.559448810935;22095.66856497154;42445.78777106095;42577;42667.15995560415;42904.14191716148;42938.92652683708;11339.886601134049;11375.431228438545;11385.886141138482;11500.367479788525;11597.536098555964;9396.95301523488;9500.42997420157;9518.381305215138;9529;9611.711648650411;11194.608188713355;11271.154663400277;11472.827907581393;11562;11929.821052684216;3824.9235015299537;3950.9209815804097;4367.694261401672;4460;4515.796789144496;965.2229954886384;967.9177269932135;977.1449981266392;983.341161421849;985.0838719990478;19292.517687057654;19585.314513991943;19598;19807.306744263882;20024.49938751543;1033.3489901362093;1038.2298181600354;1040.4641609571077;1041.5833666533447;1050.3426331381618;10576.682699519026;10726.839097413545;10997.945010274898;11078.778424431466;11151.052160566443;437817;448779;462872;469582;469897;113776;114185;115489.4225528867;115983;118129;1159.1190695071807;1177.7703347847087;1185.7450648110525;1188.287027783323;1190.7082764722525;17708.380206692706;17777.644447110728;17780.733289000935;17888.373906913195;17891.642167156322;54509.72745136249;55033;55505.44494555003;56395.43604563902;57784.4221557779;71786.28213717796;72152.27847721665;72544.27455725586;72917.27082729105;73549.63225184054;19266.903665481583;19926.90036549808;19961;19994.100265488378;20032.098555564742;21858.67211991853;22307.330780076623;22332.33003009912;22380.77619223787;22428.551428971004;16370.75443868319;16576.66846663084;16838;16863.66272674515;17017.064061476736;15806.783761358494;16328.183590820649;16579;16988.320467181173;17008.659826803643;15144.242787860783;15821.604459888595;15857.286422111263;16079.598010049842;16099.597510062342;19310.903445482683;19333.323333683253;19419.8058019418;19527.70708439346;19809.40571782849;15795.36818527246;15865.603359916095;15883.52349429519;16002.279897404413;16015.91992040079 17:56:38 INFO - PID 3793 | |3;mootools.html;1334.9199048057117;1399.8950078744097;1407.3244842475606;1416.6883285677147;1417.2346932656367;12537.749245015095;13234.205947643137;13235.933820330896;15447.30487128079;15785.60535986601;15271.618209544738;15577;15582.766258506132;15583.92208038961;15584;2682.3160094176005;2725.1143378402;2726.481968426003;2729.1539622717023;2729.7952653550965;2682.597610358452;2737.397772490049;2786.860656967154;2789.497890379731;2805.074325472589;2737.671479422472;2791.5673070673975;2791.9022834200705;2792.4833905727505;2793.329600895791;2668.533006723825;2673.8262012969194;2680.6515153030077;2718.6329845470805;2721.4557088582164;2600.2849216465625;2624.7637712605956;2628.1983994881552;2630.6974697909795;2648.20553833851;14879.256037198096;14959;14999.775003374958;15005.174715390649;15021.948463607552;8022.759317220492;8256.83486330276;8287.751367458986;8292.04641466233;8316.667333306661;5414.40441551429;5468.890622187574;5546.112621980464;5567.777288908439;5646.915296270559;1876.5644282124185;1897.0799162406222;1898.8291053805224;1961.4213806926991;1965.2433812981963;26648.86675566629;27376.315592110157;27405.86297068522;27409.17772466829;27431.314217144532;7144.821379465451;7350.669219885118;7441.739539116105;7489.28851759082;7513.962430187923;20842;20887.68668469974;20887.79112208889;20892.686609700868;20925.37223883286;8074.515529068275;8217.630206640715;8238.134995825472;8247.670093196324;8345.123762005023;6859.211190713132;6950.54821436605;7074.292570742988;7093.9359096135995;7393.704251829974;5613.831585052455;5701.885962280731;5782.190493330937;5792.333881603585;5817.7382017809305;1637.7134001549682;1696.7030769615515;1760.3046796515305;1838.264694122335;1863.3850829226324;906.8503696890072;923.7413524213231;931.743770463128;933.7385532051037;937.2829785214317;8717.433366831136;8760.649574017096;8780.736577902673;8785.428947118417;8950.104989500998;992.9205663546899;999.2256001598819;1004.9748756281151;1005.653049697853;1017.3133135133755;4708.411448568929;4782.545658162469;5472.097103977799;5584.385717571064;5594.552435805126;20904.268350607657;21117.366479005654;21796;21820.127194912344;21898.89050554737;21090.683639745417;21312.254071107436;21823.67264491034;21970.121195152016;21983.23058692938;11506.021988130935;11647.708807279885;11658.76682466363;11664.6500604982;11693.590724324778;8545.700900468453;8750.431221970552;8751.124887511452;8787.34094942869;8803.515806630441;18214.45356639303;18578.628427431646;18794.15426305847;18964.241430343183;19022;19401.70897436568;19436.514087147934;19439.3196238131;19588.608227835648;19774.30789922346;12037.518499259932;12282.508699651913;12367.072469564639;12376.319302438093;12425;12995.480180792661;13043.673908152372;13193.472261109448;13205.93397033047;13219.074664773374;11290.830637540608;11506.597269095542;11636.709082273012;11772.52909883595;12014.63956081319;11107.777844443228;11119.444027798416;11285.21003529745;11339.489722962322;11481.770364592829;9859.408435493893;9882.4564648945;9897.65358212459;10023.298369114093;10062.597496100367;7513.098428188652;7570.16728159913;7586.506877052974;7595.392368610387;7742.496737712031;7560.3573696236435;7607.23927607257;7666.501677390952;7669.5398276103615;7827.412944029106 17:56:38 INFO - PID 3793 | |4;prototype.html;517.7747679759304;524.7612336386943;530.2337084209224;535.582245848238;554.2268535393126;6091.177691011718;6192.845178870531;6195.969020154893;6234.251889773228;6264.780732674358;6152;6162;6162.691865406723;6176.907346389797;6201.565890387675;5171.146760784466;5199.324087868572;5200.141976573861;5206.24509446131;5226.8693282667855;4834.081524510332;4892.828750993716;5076.01017801527;5085.821996230133;5193.818216362428;4881.731504767236;4887.16918123918;4898.387701537308;4932;4943.555080042795;4876.463589005207;4885.975570122127;4933.432655244657;4938.580220681229;4974.87562810929;4294.441722576076;4435.401220835178;4444;4451.332300154971;4466.441694788152;5905.734241959122;5937.376575459601;5981.282246130449;6006.429389208019;6039.792041591655;5578.374056863031;5588.86027849303;5606.607537472338;5627.352854421753;5656.963493142465;6341.334159913189;6417.582857114319;6421.678916054178;6483.481321494316;6493.902591461132;4639.652026098056;4898.755062246909;4911.091448082117;4919.975400123012;4920.3357546731095;6480.31956644555;6521.771737989147;6696.2299335576545;6754.662266886685;6763.289854565298;4998.975005124951;5001.24981252815;5009.073321435546;5011.448740638527;5014.398272207359;5059.671121377099;5100.158473851773;5112.309838171874;5125.513076257749;5133.486651334912;5667.943320566742;5687.914681279784;5699.860027994418;5706.115552089433;5706.115552089433;6434.101939927733;6447.70985305653;6481.384268494486;6485.383888530677;6488.935110648833;1710.7340567979854;1739.0869793358588;1740.382164331644;1742.9912850435667;1751.5621094726318;943.3208090175063;1231.4273862653909;1232.280968049566;1241.7951038078616;1254.2349167008117;5540.36285827135;5565.332160140809;5567.526760225426;5616.427400327915;5630.662160270397;6515.4787616990525;6558.360409897526;6578.5395022347975;6639.136912201479;6648.66756662165;5581.214011516276;5607.495325420732;5619.325680918234;5623.606347555632;5638.182463542763;3472.808995505221;3482.3209474152295;3511.2450823073164;3521.0845180252804;3530.4174811156386;6350.142730731384;6352.443651305367;6379.425851673279;6409.807705768834;6457.709403076873;6692;6700.162479690039;6706.865862682719;6712.228093769181;6733.6296503692765;6361.236651601653;6373.267074286424;6399.848027355028;6411.647359395278;6455.61266324022;5912.970435147797;6458.321876203119;6546.149000629887;6599;6617.569857959217;6292.779752708633;6393.009083592051;6434.292227855026;6499.350064993463;6550.213974323112;6263.311035785969;6337.271213810286;6351.237851457855;6358.809235722936;6364.459020983269;4841.685290456109;4957.100096443477;4958.528939750718;4967.925481117858;4984.277279794337;6309.413140612327;6408.775692850728;6462.644554549357;6604.339566043357;6657.234418041987;6164.075388691553;6301.771154624804;6320.367963203643;6327.873442531031;6330.9237429638;6229.750809967551;6352.237731472253;6360.586561873463;6360.77737279193;6363.459105976044;6250.718717657625;6271.3415091414745;6292.716827742671;6309.589876658002;6316.368363163647;6321.468714874485;6323.6838158090995;6352.523560733056;6358.809235722936;6391;6077.604955678044;6111.472131967008;6150.354212807591;6153.169322141453;6166.845828854314 17:56:38 INFO - PID 3793 | |5;yui.html;901.197933838883;908.7273817854643;928.3455164109304;936.4474959773733;950.672018153737;19066;19653.50866228345;19731.60536789265;19731.704024439645;19732.704009439833;17801;17885.374011909586;18127.81872181278;19607.705884411746;19759.604807903834;980.3970558106766;982.7837875667342;983.9704808855746;985.4333758089092;985.6895078050392;956.5982287439257;985.8816941966974;988.9258305627071;989.2975987049203;989.3025417080977;1048.3133547526381;1048.6644273832376;1050.03921411908;1051.6844946516053;1052.2423854824515;1032.050513527549;1038.6001389465073;1041.656253436364;1041.906228439444;1047.9423631700254;765.2271206081841;765.8200322924108;766.8427972265672;770.3913908012663;774.6281784743298;20029.09869055896;20078;20227.898860505604;20343.49141271465;20467.795322046888;21599;21662.89168554163;22214.777852221596;22233.11067557312;22239.777602224094;17779;17779.377721779805;17830.643387132186;17879.910600447045;17925.103744812837;3565;3602.2975519773654;3609.62098979606;3628.2380700053022;3633.255182687543;141218.2939085298;141982;142100.28949855184;143969;144411.27794361065;16789.664206716043;16921.40775072891;17470.30118795234;17490.125493725263;17528.73706894372;30744.84627576848;30755.384892302027;30774.84612576923;30867.845660771553;30925.845370773;8918.420302680304;8932.687355942511;8982.191602755784;8990.415622984485;9032.729018129467;4041.2725709372594;4050.1899620075515;4091.1817636472824;4134.111166099303;4136.772477513766;5347.759350829222;5362.51737343641;5390.784368625211;5446.046941785172;5454.672719636835;945.9858102128474;952.9285303602257;969.1858838575489;973.4110862927968;974.4737841565475;652.915121034272;675.5473832532215;685.8456847209437;690.0167261652126;694.1565997313288;10750.248616989873;10798;11425.428728563538;12093.516259349528;12265.57070502528;693.9653017349112;700.4851434195862;702.3222590200481;708.9539179953287;710.9537880037781;5502.614816962774;5510.264266755959;5562.499375056264;5635.633683810539;5678.176664383641;115875;121322;121544;122762;124091.3795431017;109367;109772;111117;112969;113723.43138284255;88307.558462206;89298;92151.0784892156;92516;92899.53550232206;10319.690409287734;10362.948185259025;10384.532696028546;10418.895811041793;10462.581496740046;43635;43975.78012109919;44296.55703443053;46461.53538464572;46484.7675761619;56733.71633141808;56828.71585642211;57529.13706294325;57580.71209643925;58502.414975851396;16094.597635059217;16448.663328100967;16490.422835200712;16624.168791560132;16675.082870442242;16607.252673629475;16670.666586667958;16738.58153546171;16748.330066797193;16826.915865420593;16616.916915415346;16637.251323690703;16814.327426902786;16919.830801691827;16936.57658558546;14727.631809204855;14963.34864012684;14994.2502874858;15047.473338433103;15146.394144234107;16612.916935415727;16651.83348166551;16671.333146674;16814.327426902786;17112.229949652046;10948.945255273673;11014.724631884266;11046.392448415414;11108.944455277671;11274.37990910475;11527.374642173543;11684.357360344922;11722.58970936013;11898.940505297418;12057.879421205676 17:56:38 INFO - PID 3793 | __end_tp_report 17:56:38 INFO - PID 3793 | __start_cc_report 17:56:38 INFO - PID 3793 | _x_x_mozilla_cycle_collect,304 17:56:38 INFO - PID 3793 | __end_cc_report 17:56:38 INFO - PID 3793 | __startTimestamp1506387398982__endTimestamp 17:56:38 INFO - PID 3793 | 17:56:38 INFO - PID 3793 | ------- Summary: start ------- 17:56:38 INFO - PID 3793 | Number of tests: 6 17:56:38 INFO - PID 3793 | 17:56:38 INFO - PID 3793 | [#0] dojo.html Cycles:165 Average:6096.07 Median:6377.97 stddev:875.57 (13.7%) stddev-sans-first:845.74 17:56:38 INFO - PID 3793 | Values: 3082.7 3083.4 3088.2 3094.2 3097.1 6025.0 6043.7 6130.9 6167.2 6212.4 6112.0 6125.4 6139.4 6160.2 6263.3 5799.6 5832.3 5837.5 5861.1 5872.1 30.8 5801.7 5868.2 5894.8 5895.0 5664.9 5693.5 5720.0 5817.9 5822.3 5696.9 5767.9 5801.2 5823.4 5833.6 5681.7 5695.3 5751.9 5799.8 5801.4 6123.8 6166.7 6224.5 6304.1 6314.4 6505.4 6585.0 6598.7 6684.9 6690.4 6623.3 6627.3 6637.5 6665.2 6671.2 6038.6 6132.7 6202.8 6243.1 6324.0 6871.3 6897.5 6956.0 6960.3 6960.7 6558.5 6586.8 6630.8 6656.4 6695.4 6446.8 6566.5 6627.9 6695.7 6706.0 6597.7 6663.9 6684.0 6711.5 6715.7 6593.7 6665.9 6686.7 6750.3 6762.0 5147.3 5253.6 5256.4 5265.7 5270.8 4550.4 4573.1 4573.4 4580.6 4583.6 5598.0 5604.1 5607.7 5614.8 5632.0 6535.2 6622.9 6629.6 6630.9 6708.6 5733.1 5745.5 5763.9 5783.6 5791.1 5729.1 5737.8 5815.2 5828.8 5836.6 6295.0 6373.2 6452.2 6465.5 6548.7 6691.3 6726.8 6732.1 6735.3 6749.9 6413.5 6450.4 6493.0 6515.5 6553.4 6407.8 6542.3 6553.2 6634.0 6662.3 6602.9 6628.4 6665.6 6672.4 6682.0 6475.1 6526.2 6545.3 6545.6 6545.8 6443.9 6485.9 6545.0 6545.6 6546.6 6362.7 6363.8 6392.4 6444.1 6449.1 6320.1 6507.5 6536.8 6600.7 6609.0 6364.4 6364.7 6378.0 6391.3 6410.6 17:56:38 INFO - PID 3793 | 17:56:38 INFO - PID 3793 | [#1] ext.html Cycles:180 Average:35970.00 Median:19705.62 stddev:49202.14 (249.7%) stddev-sans-first:49269.26 17:56:38 INFO - PID 3793 | Values: 791.4 791.8 810.9 834.6 837.3 41101.4 41868.0 41877.6 42006.4 42052.2 37659.0 41660.4 42500.6 42582.6 42621.0 7605.5 7730.0 7742.4 7743.9 7748.6 7558.8 7633.8 7639.9 7662.9 7677.3 7670.8 7710.7 7714.0 7714.4 7752.3 7616.6 7656.8 7660.6 7698.4 7699.5 7486.7 7552.8 7554.2 7558.8 7571.3 38044.0 38239.0 38312.2 38335.6 38366.0 3520.5 3534.5 3553.9 3562.6 3564.0 30973.5 31177.0 31232.0 31265.7 31347.2 4765.3 4915.8 4922.3 4938.3 4953.7 184584.0 184870.0 185669.0 185778.0 186621.0 47005.5 47128.5 47136.3 47176.1 47377.3 49019.8 49237.3 49307.5 49412.5 49487.0 13907.0 14173.9 14256.7 14267.6 14270.1 11288.1 11293.2 11340.7 11359.1 11411.2 13005.2 13292.5 13311.9 13312.4 13319.7 5110.6 5128.5 5151.7 5176.2 5215.2 1004.4 1019.8 1027.5 1032.5 1048.6 22594.3 23136.9 23139.9 23160.9 23251.9 1094.6 1117.5 1122.3 1138.3 1147.3 11974.1 12292.4 12356.8 12367.9 12395.4 225923.0 227003.0 227774.0 228238.0 228299.0 53535.5 58277.4 58326.0 58587.7 58688.0 1458.3 1490.8 1501.7 1506.0 1508.8 26797.6 27230.5 27481.7 27528.9 27815.7 38102.6 38448.2 38488.0 38516.8 38531.6 146243.0 146518.0 146666.3 146916.0 146924.3 36396.6 36480.0 36537.0 36617.0 36919.3 41464.8 42850.6 42928.0 43171.8 43800.8 31513.5 31713.5 32101.7 32131.0 32191.2 31508.4 31558.2 31700.2 31923.8 31932.0 35603.5 35847.3 35895.0 36192.0 36299.8 30117.0 30316.2 30648.0 30982.7 31080.0 22271.6 22757.2 22866.1 23125.9 23128.8 17:56:39 INFO - PID 3793 | 17:56:39 INFO - PID 3793 | [#2] jquery.html Cycles:180 Average:34881.12 Median:22061.61 stddev:77658.79 (352.0%) stddev-sans-first:77833.99 17:56:39 INFO - PID 3793 | Values: 601.0 602.6 605.4 614.8 619.2 21857.5 22534.3 22547.1 22560.3 22584.4 23026.4 24245.2 24350.0 24439.1 24475.8 6169.1 6363.8 6365.8 6370.2 6372.5 6214.8 6314.9 6592.7 6800.7 6876.1 6805.1 6808.7 6821.9 6837.6 6838.0 6776.9 6817.3 6822.4 6828.2 6844.4 6631.6 6634.2 6676.2 6686.4 6715.1 27787.2 29257.3 29731.3 30020.7 30037.2 2057.2 2073.4 2092.3 2094.9 2101.0 19787.4 19926.6 20874.7 20896.2 20896.9 2296.2 2305.8 2374.7 2379.8 2381.2 126342.0 129437.4 145932.0 150125.0 150476.0 20094.3 21173.0 21651.9 22027.6 22095.7 42445.8 42577.0 42667.2 42904.1 42938.9 11339.9 11375.4 11385.9 11500.4 11597.5 9397.0 9500.4 9518.4 9529.0 9611.7 11194.6 11271.2 11472.8 11562.0 11929.8 3824.9 3950.9 4367.7 4460.0 4515.8 965.2 967.9 977.1 983.3 985.1 19292.5 19585.3 19598.0 19807.3 20024.5 1033.3 1038.2 1040.5 1041.6 1050.3 10576.7 10726.8 10997.9 11078.8 11151.1 437817.0 448779.0 462872.0 469582.0 469897.0 113776.0 114185.0 115489.4 115983.0 118129.0 1159.1 1177.8 1185.7 1188.3 1190.7 17708.4 17777.6 17780.7 17888.4 17891.6 54509.7 55033.0 55505.4 56395.4 57784.4 71786.3 72152.3 72544.3 72917.3 73549.6 19266.9 19926.9 19961.0 19994.1 20032.1 21858.7 22307.3 22332.3 22380.8 22428.6 16370.8 16576.7 16838.0 16863.7 17017.1 15806.8 16328.2 16579.0 16988.3 17008.7 15144.2 15821.6 15857.3 16079.6 16099.6 19310.9 19333.3 19419.8 19527.7 19809.4 15795.4 15865.6 15883.5 16002.3 16015.9 17:56:39 INFO - PID 3793 | 17:56:39 INFO - PID 3793 | [#3] mootools.html Cycles:180 Average:9577.43 Median:14658.70 stddev:6836.59 (46.6%) stddev-sans-first:6827.72 17:56:39 INFO - PID 3793 | Values: 1334.9 1399.9 1407.3 1416.7 1417.2 12537.7 13234.2 13235.9 15447.3 15785.6 15271.6 15577.0 15582.8 15583.9 15584.0 2682.3 2725.1 2726.5 2729.2 2729.8 2682.6 2737.4 2786.9 2789.5 2805.1 2737.7 2791.6 2791.9 2792.5 2793.3 2668.5 2673.8 2680.7 2718.6 2721.5 2600.3 2624.8 2628.2 2630.7 2648.2 14879.3 14959.0 14999.8 15005.2 15021.9 8022.8 8256.8 8287.8 8292.0 8316.7 5414.4 5468.9 5546.1 5567.8 5646.9 1876.6 1897.1 1898.8 1961.4 1965.2 26648.9 27376.3 27405.9 27409.2 27431.3 7144.8 7350.7 7441.7 7489.3 7514.0 20842.0 20887.7 20887.8 20892.7 20925.4 8074.5 8217.6 8238.1 8247.7 8345.1 6859.2 6950.5 7074.3 7093.9 7393.7 5613.8 5701.9 5782.2 5792.3 5817.7 1637.7 1696.7 1760.3 1838.3 1863.4 906.9 923.7 931.7 933.7 937.3 8717.4 8760.6 8780.7 8785.4 8950.1 992.9 999.2 1005.0 1005.7 1017.3 4708.4 4782.5 5472.1 5584.4 5594.6 20904.3 21117.4 21796.0 21820.1 21898.9 21090.7 21312.3 21823.7 21970.1 21983.2 11506.0 11647.7 11658.8 11664.7 11693.6 8545.7 8750.4 8751.1 8787.3 8803.5 18214.5 18578.6 18794.2 18964.2 19022.0 19401.7 19436.5 19439.3 19588.6 19774.3 12037.5 12282.5 12367.1 12376.3 12425.0 12995.5 13043.7 13193.5 13205.9 13219.1 11290.8 11506.6 11636.7 11772.5 12014.6 11107.8 11119.4 11285.2 11339.5 11481.8 9859.4 9882.5 9897.7 10023.3 10062.6 7513.1 7570.2 7586.5 7595.4 7742.5 7560.4 7607.2 7666.5 7669.5 7827.4 17:56:39 INFO - PID 3793 | 17:56:39 INFO - PID 3793 | [#4] prototype.html Cycles:180 Average:5413.41 Median:6084.39 stddev:1492.54 (24.5%) stddev-sans-first:1450.79 17:56:39 INFO - PID 3793 | Values: 517.8 524.8 530.2 535.6 554.2 6091.2 6192.8 6196.0 6234.3 6264.8 6152.0 6162.0 6162.7 6176.9 6201.6 5171.1 5199.3 5200.1 5206.2 5226.9 4834.1 4892.8 5076.0 5085.8 5193.8 4881.7 4887.2 4898.4 4932.0 4943.6 4876.5 4886.0 4933.4 4938.6 4974.9 4294.4 4435.4 4444.0 4451.3 4466.4 5905.7 5937.4 5981.3 6006.4 6039.8 5578.4 5588.9 5606.6 5627.4 5657.0 6341.3 6417.6 6421.7 6483.5 6493.9 4639.7 4898.8 4911.1 4920.0 4920.3 6480.3 6521.8 6696.2 6754.7 6763.3 4999.0 5001.2 5009.1 5011.4 5014.4 5059.7 5100.2 5112.3 5125.5 5133.5 5667.9 5687.9 5699.9 5706.1 5706.1 6434.1 6447.7 6481.4 6485.4 6488.9 1710.7 1739.1 1740.4 1743.0 1751.6 943.3 1231.4 1232.3 1241.8 1254.2 5540.4 5565.3 5567.5 5616.4 5630.7 6515.5 6558.4 6578.5 6639.1 6648.7 5581.2 5607.5 5619.3 5623.6 5638.2 3472.8 3482.3 3511.2 3521.1 3530.4 6350.1 6352.4 6379.4 6409.8 6457.7 6692.0 6700.2 6706.9 6712.2 6733.6 6361.2 6373.3 6399.8 6411.6 6455.6 5913.0 6458.3 6546.1 6599.0 6617.6 6292.8 6393.0 6434.3 6499.4 6550.2 6263.3 6337.3 6351.2 6358.8 6364.5 4841.7 4957.1 4958.5 4967.9 4984.3 6309.4 6408.8 6462.6 6604.3 6657.2 6164.1 6301.8 6320.4 6327.9 6330.9 6229.8 6352.2 6360.6 6360.8 6363.5 6250.7 6271.3 6292.7 6309.6 6316.4 6321.5 6323.7 6352.5 6358.8 6391.0 6077.6 6111.5 6150.4 6153.2 6166.8 17:56:39 INFO - PID 3793 | 17:56:39 INFO - PID 3793 | [#5] yui.html Cycles:180 Average:24366.43 Median:20053.55 stddev:35418.54 (176.6%) stddev-sans-first:35474.08 17:56:39 INFO - PID 3793 | Values: 901.2 908.7 928.3 936.4 950.7 19066.0 19653.5 19731.6 19731.7 19732.7 17801.0 17885.4 18127.8 19607.7 19759.6 980.4 982.8 984.0 985.4 985.7 956.6 985.9 988.9 989.3 989.3 1048.3 1048.7 1050.0 1051.7 1052.2 1032.1 1038.6 1041.7 1041.9 1047.9 765.2 765.8 766.8 770.4 774.6 20029.1 20078.0 20227.9 20343.5 20467.8 21599.0 21662.9 22214.8 22233.1 22239.8 17779.0 17779.4 17830.6 17879.9 17925.1 3565.0 3602.3 3609.6 3628.2 3633.3 141218.3 141982.0 142100.3 143969.0 144411.3 16789.7 16921.4 17470.3 17490.1 17528.7 30744.8 30755.4 30774.8 30867.8 30925.8 8918.4 8932.7 8982.2 8990.4 9032.7 4041.3 4050.2 4091.2 4134.1 4136.8 5347.8 5362.5 5390.8 5446.0 5454.7 946.0 952.9 969.2 973.4 974.5 652.9 675.5 685.8 690.0 694.2 10750.2 10798.0 11425.4 12093.5 12265.6 694.0 700.5 702.3 709.0 711.0 5502.6 5510.3 5562.5 5635.6 5678.2 115875.0 121322.0 121544.0 122762.0 124091.4 109367.0 109772.0 111117.0 112969.0 113723.4 88307.6 89298.0 92151.1 92516.0 92899.5 10319.7 10362.9 10384.5 10418.9 10462.6 43635.0 43975.8 44296.6 46461.5 46484.8 56733.7 56828.7 57529.1 57580.7 58502.4 16094.6 16448.7 16490.4 16624.2 16675.1 16607.3 16670.7 16738.6 16748.3 16826.9 16616.9 16637.3 16814.3 16919.8 16936.6 14727.6 14963.3 14994.3 15047.5 15146.4 16612.9 16651.8 16671.3 16814.3 17112.2 10948.9 11014.7 11046.4 11108.9 11274.4 11527.4 11684.4 11722.6 11898.9 12057.9 17:56:39 INFO - PID 3793 | -------- Summary: end -------- 17:56:39 INFO - PID 3793 | 17:56:39 INFO - TEST-INFO | 3793: exit 0 17:56:39 INFO - TEST-OK | dromaeo_css | took 1111391ms 17:56:39 INFO - TEST-START | kraken 17:56:39 INFO - Initialising browser for kraken test... 17:56:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48550/getInfo.html -profile /tmp/tmpQi0B8f/profile 17:56:39 INFO - TEST-INFO | started process 4155 (/builds/slave/test/build/application/firefox/firefox http://localhost:48550/getInfo.html) 17:56:45 INFO - TEST-INFO | 4155: exit 0 17:56:45 INFO - Browser initialized. 17:56:45 INFO - Running cycle 1/1 for kraken test... 17:56:45 INFO - Using env: {'DISPLAY': ':0', 17:56:45 INFO - 'HOME': '/home/cltbld', 17:56:45 INFO - 'JSGC_DISABLE_POISONING': '1', 17:56:45 INFO - 'LANG': 'en_US.UTF-8', 17:56:45 INFO - 'LANGUAGE': 'en_US:en', 17:56:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:56:45 INFO - 'LOGNAME': 'cltbld', 17:56:45 INFO - 'MAIL': '/var/mail/cltbld', 17:56:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:56:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:56:45 INFO - 'MOZ_CRASHREPORTER': '1', 17:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:56:45 INFO - 'MOZ_NO_REMOTE': '1', 17:56:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:45 INFO - 'NO_EM_RESTART': '1', 17:56:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:45 INFO - 'PWD': '/builds/slave/test', 17:56:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:56:45 INFO - 'RUST_BACKTRACE': 'full', 17:56:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:56:45 INFO - 'SHELL': '/bin/bash', 17:56:45 INFO - 'SHLVL': '1', 17:56:45 INFO - 'STYLO_FORCE_DISABLED': '1', 17:56:45 INFO - 'TERM': 'linux', 17:56:45 INFO - 'TMOUT': '86400', 17:56:45 INFO - 'USER': 'cltbld', 17:56:45 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363', 17:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:45 INFO - '_': '/tools/buildbot/bin/python'} 17:56:45 INFO - TEST-INFO | started process 4391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQi0B8f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:46 INFO - PID 4391 | 17:56:46 INFO - PID 4391 | (/builds/slave/test/build/application/firefox/firefox:4440): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:56:46 INFO - PID 4391 | 17:56:56 INFO - PID 4391 | RSS: Main: 151547904 17:56:56 INFO - PID 4391 | 17:56:59 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48550/tests/kraken/driver.html?testName=audio-beat-detection) 17:57:00 INFO - PID 4391 | RSS: Main: 157601792 17:57:00 INFO - PID 4391 | 17:57:02 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48550/tests/kraken/driver.html?testName=audio-dft) 17:57:03 INFO - PID 4391 | RSS: Main: 157958144 17:57:03 INFO - PID 4391 | 17:57:06 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48550/tests/kraken/driver.html?testName=audio-fft) 17:57:07 INFO - PID 4391 | RSS: Main: 154800128 17:57:07 INFO - PID 4391 | 17:57:09 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48550/tests/kraken/driver.html?testName=audio-oscillator) 17:57:09 INFO - PID 4391 | RSS: Main: 155570176 17:57:09 INFO - PID 4391 | 17:57:11 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48550/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:57:12 INFO - PID 4391 | RSS: Main: 155418624 17:57:12 INFO - PID 4391 | 17:57:15 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48550/tests/kraken/driver.html?testName=imaging-darkroom) 17:57:16 INFO - PID 4391 | RSS: Main: 157929472 17:57:16 INFO - PID 4391 | 17:57:19 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48550/tests/kraken/driver.html?testName=imaging-desaturate) 17:57:20 INFO - PID 4391 | RSS: Main: 157634560 17:57:20 INFO - PID 4391 | 17:57:23 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48550/tests/kraken/driver.html?testName=json-parse-financial) 17:57:24 INFO - PID 4391 | RSS: Main: 158756864 17:57:24 INFO - PID 4391 | 17:57:25 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48550/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:57:26 INFO - PID 4391 | RSS: Main: 158265344 17:57:26 INFO - PID 4391 | 17:57:27 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48550/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:57:28 INFO - PID 4391 | RSS: Main: 158220288 17:57:28 INFO - PID 4391 | 17:57:30 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48550/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:57:31 INFO - PID 4391 | RSS: Main: 154963968 17:57:31 INFO - PID 4391 | 17:57:34 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48550/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:57:34 INFO - PID 4391 | RSS: Main: 155463680 17:57:34 INFO - PID 4391 | 17:57:37 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48550/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:57:38 INFO - PID 4391 | RSS: Main: 154984448 17:57:38 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | Cycle 1(1): loaded http://localhost:48550/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48550/tests/kraken/driver.html?testName=ai-astar) 17:57:40 INFO - PID 4391 | RSS: Main: 156971008 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | __start_tp_report 17:57:40 INFO - PID 4391 | _x_x_mozilla_page_load 17:57:40 INFO - PID 4391 | _x_x_mozilla_page_load_details 17:57:40 INFO - PID 4391 | |i|pagename|runs| 17:57:40 INFO - PID 4391 | |0;ai-astar;108;108;108;108;108;108;110;109;107;107 17:57:40 INFO - PID 4391 | |1;audio-beat-detection;117;121;117;115;121;116;119;115;143;120 17:57:40 INFO - PID 4391 | |2;audio-dft;163;162;162;163;164;162;163;164;168;167 17:57:40 INFO - PID 4391 | |3;audio-fft;78;75;74;74;75;75;74;74;74;74 17:57:40 INFO - PID 4391 | |4;audio-oscillator;81;81;80;80;80;80;81;80;79;80 17:57:40 INFO - PID 4391 | |5;imaging-gaussian-blur;113;114;114;118;116;117;117;118;116;114 17:57:40 INFO - PID 4391 | |6;imaging-darkroom;152;148;149;148;148;149;148;148;148;148 17:57:40 INFO - PID 4391 | |7;imaging-desaturate;95;99;94;94;94;95;95;95;94;100 17:57:40 INFO - PID 4391 | |8;json-parse-financial;56;58;56;54;54;55;56;54;53;54 17:57:40 INFO - PID 4391 | |9;json-stringify-tinderbox;40;38;41;39;38;39;38;39;38;39 17:57:40 INFO - PID 4391 | |10;stanford-crypto-aes;73;72;73;75;77;78;74;72;73;72 17:57:40 INFO - PID 4391 | |11;stanford-crypto-ccm;118;120;110;120;116;120;117;112;118;119 17:57:40 INFO - PID 4391 | |12;stanford-crypto-pbkdf2;176;169;174;175;177;169;182;183;176;171 17:57:40 INFO - PID 4391 | |13;stanford-crypto-sha256-iterative;66;66;66;67;64;72;65;66;75;67 17:57:40 INFO - PID 4391 | __end_tp_report 17:57:40 INFO - PID 4391 | __start_cc_report 17:57:40 INFO - PID 4391 | _x_x_mozilla_cycle_collect,721 17:57:40 INFO - PID 4391 | __end_cc_report 17:57:40 INFO - PID 4391 | __startTimestamp1506387460333__endTimestamp 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | ------- Summary: start ------- 17:57:40 INFO - PID 4391 | Number of tests: 14 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#0] ai-astar Cycles:10 Average:108.10 Median:108.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 17:57:40 INFO - PID 4391 | Values: 108.0 108.0 108.0 108.0 108.0 108.0 110.0 109.0 107.0 107.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#1] audio-beat-detection Cycles:10 Average:120.40 Median:119.50 stddev:8.26 (6.9%) stddev-sans-first:8.67 17:57:40 INFO - PID 4391 | Values: 117.0 121.0 117.0 115.0 121.0 116.0 119.0 115.0 143.0 120.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.10 (1.3%) stddev-sans-first:2.20 17:57:40 INFO - PID 4391 | Values: 163.0 162.0 162.0 163.0 164.0 162.0 163.0 164.0 168.0 167.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#3] audio-fft Cycles:10 Average:74.70 Median:74.50 stddev:1.25 (1.7%) stddev-sans-first:0.50 17:57:40 INFO - PID 4391 | Values: 78.0 75.0 74.0 74.0 75.0 75.0 74.0 74.0 74.0 74.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:80.00 stddev:0.63 (0.8%) stddev-sans-first:0.60 17:57:40 INFO - PID 4391 | Values: 81.0 81.0 80.0 80.0 80.0 80.0 81.0 80.0 79.0 80.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:116.50 stddev:1.83 (1.6%) stddev-sans-first:1.66 17:57:40 INFO - PID 4391 | Values: 113.0 114.0 114.0 118.0 116.0 117.0 117.0 118.0 116.0 114.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.00 stddev:1.26 (0.9%) stddev-sans-first:0.44 17:57:40 INFO - PID 4391 | Values: 152.0 148.0 149.0 148.0 148.0 149.0 148.0 148.0 148.0 148.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:2.17 (2.3%) stddev-sans-first:2.30 17:57:40 INFO - PID 4391 | Values: 95.0 99.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 100.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:1.49 (2.7%) stddev-sans-first:1.54 17:57:40 INFO - PID 4391 | Values: 56.0 58.0 56.0 54.0 54.0 55.0 56.0 54.0 53.0 54.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:39.00 stddev:0.99 (2.5%) stddev-sans-first:0.97 17:57:40 INFO - PID 4391 | Values: 40.0 38.0 41.0 39.0 38.0 39.0 38.0 39.0 38.0 39.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.50 stddev:2.13 (2.9%) stddev-sans-first:2.24 17:57:40 INFO - PID 4391 | Values: 73.0 72.0 73.0 75.0 77.0 78.0 74.0 72.0 73.0 72.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:118.50 stddev:3.46 (2.9%) stddev-sans-first:3.66 17:57:40 INFO - PID 4391 | Values: 118.0 120.0 110.0 120.0 116.0 120.0 117.0 112.0 118.0 119.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:176.00 stddev:4.80 (2.7%) stddev-sans-first:5.09 17:57:40 INFO - PID 4391 | Values: 176.0 169.0 174.0 175.0 177.0 169.0 182.0 183.0 176.0 171.0 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:66.50 stddev:3.41 (5.1%) stddev-sans-first:3.57 17:57:40 INFO - PID 4391 | Values: 66.0 66.0 66.0 67.0 64.0 72.0 65.0 66.0 75.0 67.0 17:57:40 INFO - PID 4391 | -------- Summary: end -------- 17:57:40 INFO - PID 4391 | 17:57:40 INFO - PID 4391 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:57:40 INFO - TEST-INFO | 4391: exit 0 17:57:40 INFO - TEST-OK | kraken | took 61235ms 17:57:40 INFO - SUITE-END | took 1172s 17:57:40 INFO - Completed test suite (00:19:32) 17:57:40 INFO - javascript benchmark 17:57:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8559.909504784158, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.676318986505, 3083.4449799036165, 3088.197068762122, 3094.180042288793, 3097.0553981035773, 6025.0, 6043.728032238549, 6130.877382452349, 6167.167432396625, 6212.409821066997, 6112.0, 6125.387461253872, 6139.4167554082405, 6160.168377269068, 6263.3423490533405, 5799.594028418012, 5832.300123985117, 5837.532997360222, 5861.120831875211, 5872.060470324749, 30.823612583951927, 5801.680907550083, 5868.2371291732225, 5894.821035792858, 5895.027320492114, 5664.886702265972, 5693.544516438675, 5719.971400143014, 5817.912731309034, 5822.272215973004, 5696.857578560528, 5767.942320576783, 5801.245838041028, 5823.388544202882, 5833.620814647034, 5681.715914204273, 5695.288088988877, 5751.942480575182, 5799.768009279624, 5801.390853960315, 6123.846903827395, 6166.691665416756, 6224.502039836802, 6304.117423560705, 6314.400131987454, 6505.414512693833, 6584.967075164594, 6598.670066496656, 6684.866302673968, 6690.397864192198, 6623.337666233387, 6627.271000189975, 6637.535372523926, 6665.200175978865, 6671.199456065255, 6038.63768173911, 6132.662703551303, 6202.782902598433, 6243.063540468921, 6324.0, 6871.312868713188, 6897.48268879836, 6956.026156338066, 6960.269171736996, 6960.686769095403, 6558.508111891627, 6586.8353291168105, 6630.83422914431, 6656.36764507371, 6695.363940425652, 6446.806595802133, 6566.507511936624, 6627.86744265112, 6695.698693558801, 6706.0, 6597.670116494156, 6663.933360666331, 6683.997400389981, 6711.530192886548, 6715.6977935993, 6593.736250549924, 6665.900011499832, 6686.665666716644, 6750.291219421988, 6762.0, 5147.279380886679, 5253.632245742761, 5256.448072952285, 5265.7103859287345, 5270.814066835008, 4550.431196100488, 4573.085382923362, 4573.405457290531, 4580.58774710271, 4583.633309335245, 5598.0, 5604.075327570987, 5607.7476513556985, 5614.775408983595, 5632.04255276604, 6535.215774107138, 6622.933770662328, 6629.602223866584, 6630.933690663128, 6708.563943343667, 5733.111367738007, 5745.454181852718, 5763.88472230553, 5783.624064435799, 5791.102379131242, 5729.054705973551, 5737.827865164052, 5815.214945982323, 5828.76684932598, 5836.649801011953, 6295.0, 6373.235211774524, 6452.161219041494, 6465.515086368541, 6548.738050478023, 6691.26396096429, 6726.831829204211, 6732.057511948233, 6735.326467353323, 6749.865002700017, 6413.4869210463985, 6450.41946224842, 6493.0, 6515.54391192612, 6553.4101930826455, 6407.775727849503, 6542.295923403378, 6553.2136143663065, 6634.03806448072, 6662.300458451793, 6602.867942641216, 6628.403443690091, 6665.600063996176, 6672.4328432081875, 6682.031105489774, 6475.061116138228, 6526.184226971629, 6545.312742162005, 6545.574537655038, 6545.770898018546, 6443.935560644333, 6485.902711459426, 6544.9672751635935, 6545.574537655038, 6546.607203567801, 6362.713677884413, 6363.840903977438, 6392.3927226913365, 6444.065610486547, 6449.12936753551, 6320.08358787964, 6507.511936604868, 6536.7712130075215, 6600.669966501751, 6609.041688954979, 6364.427201551883, 6364.745410183541, 6377.96811015942, 6391.296957334783, 6410.583312084699], "value": 6034.008050518568, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.4420333664767, 791.8495485857686, 810.9107998120206, 834.58687949465, 837.3385025829594, 41101.3834792478, 41868.0, 41877.58122418775, 42006.36990445142, 42052.158956820844, 37659.0, 41660.37509437361, 42500.57499425005, 42582.57417425825, 42621.0, 7605.543667379961, 7730.0, 7742.380609551251, 7743.922560774405, 7748.573828439462, 7558.848823023563, 7633.809154771147, 7639.885401718979, 7662.885056724126, 7677.270659287359, 7670.846583068335, 7710.653020614086, 7714.0, 7714.421418393615, 7752.341051010642, 7616.581088040156, 7656.770296891074, 7660.616969151548, 7698.384129269701, 7699.4995325304235, 7486.737964171282, 7552.848943021108, 7554.169041405441, 7558.773236802905, 7571.280728330799, 38044.04889877747, 38239.0, 38312.23375532502, 38335.61664383376, 38366.0, 3520.489529018278, 3534.5228394166716, 3553.928921421583, 3562.6259242779392, 3563.964360356389, 30973.535396969062, 31177.0, 31232.0, 31265.687343126505, 31347.216319592193, 4765.332853400527, 4915.803367865281, 4922.286268491084, 4938.259261110827, 4953.702777833341, 184584.0, 184870.0, 185669.0, 185778.0, 186621.0, 47005.529944700116, 47128.5287147131, 47136.29295560569, 47176.05647887023, 47377.28934065992, 49019.75490122598, 49237.261441078415, 49307.50692493029, 49412.50587494151, 49487.0, 13907.0, 14173.858261417254, 14256.714865702836, 14267.64330891736, 14270.072445291024, 11288.0969522438, 11293.209475336811, 11340.716482088013, 11359.148063895242, 11411.201215914973, 13005.21968681882, 13292.468301268034, 13311.935045196555, 13312.400941957636, 13319.669057914825, 5110.616703747234, 5128.487151284841, 5151.665141765773, 5176.171812509981, 5215.24378965048, 1004.4224570871778, 1019.7654539455966, 1027.4554486122368, 1032.5405194688442, 1048.580567772897, 22594.322170334915, 23136.884315578314, 23139.88430057839, 23160.884195578914, 23251.88374058119, 1094.6223552874246, 1117.474786850179, 1122.3322123336602, 1138.260130914912, 1147.2772153543215, 11974.127812601315, 12292.385380730928, 12356.752864942651, 12367.93816030932, 12395.380230988414, 225923.0, 227003.0, 227774.0, 228238.0, 228299.0, 53535.46464535383, 58277.417225828045, 58326.0, 58587.70706146527, 58688.0, 1458.3364569121024, 1490.7763835424555, 1501.7371959906973, 1505.9774103388238, 1508.7963124978207, 26797.598036029085, 27230.455390892468, 27481.725182747916, 27528.862355688092, 27815.721842781313, 38102.61897381102, 38448.23103537969, 38488.037799055244, 38516.80741596274, 38531.6146838528, 146243.0, 146518.0, 146666.26666866598, 146916.0, 146924.26537867243, 36396.636033639326, 36480.0, 36537.0, 36617.0, 36919.26161476702, 41464.79267603643, 42850.57149428466, 42928.0, 43171.78414107909, 43800.78099609609, 31513.52729709102, 31713.5242971351, 32101.678983210804, 32131.0, 32191.195220119684, 31508.36983260368, 31558.211044724067, 31700.207494812814, 31923.84038079795, 31932.0, 35603.465948010286, 35847.283054338244, 35895.0, 36192.0, 36299.81850090733, 30117.0, 30316.24209394783, 30648.0, 30982.69017309798, 31080.0, 22271.6214663581, 22757.203497877494, 22866.08535658555, 23125.88437057804, 23128.76871231266], "value": 16847.90060419158, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.0473399661536, 602.6022824935542, 605.4369436424126, 614.8217017065051, 619.2135987296133, 21857.453563660918, 22534.323970280875, 22547.098116075358, 22560.323190304276, 22584.43538911526, 23026.424339391524, 24245.151419700313, 24350.0, 24439.144629937957, 24475.75524244757, 6169.074638804182, 6363.8409039773915, 6365.809025729212, 6370.203724534434, 6372.458341040994, 6214.8135555933395, 6314.905276420857, 6592.736290548372, 6800.659967001655, 6876.071730316418, 6805.149356330458, 6808.659567021654, 6821.863562728742, 6837.623930683811, 6837.965810170942, 6776.898346524806, 6817.250102488747, 6822.4200942919415, 6828.214755303154, 6844.38400543951, 6631.568948018364, 6634.170728658918, 6676.232233293184, 6686.364795344434, 6715.059891615178, 27787.16638500848, 29257.268568285752, 29731.256718582208, 30020.699793002226, 30037.249068773235, 2057.177129148338, 2073.429806803126, 2092.2677063027973, 2094.9057292421726, 2101.0020240385848, 19787.40637780869, 19926.60146797056, 20874.686879696816, 20896.164153433845, 20896.895515522327, 2296.2422400607925, 2305.8385912986096, 2374.691290132289, 2379.785819276256, 2381.20229723043, 126342.0, 129437.35281323627, 145932.0, 150125.0, 150475.9999999989, 20094.296699615737, 21173.0, 21651.891740541196, 22027.559448810935, 22095.66856497154, 42445.78777106095, 42577.0, 42667.15995560415, 42904.14191716148, 42938.92652683708, 11339.886601134049, 11375.431228438545, 11385.886141138482, 11500.367479788525, 11597.536098555964, 9396.95301523488, 9500.42997420157, 9518.381305215138, 9529.0, 9611.711648650411, 11194.608188713355, 11271.154663400277, 11472.827907581393, 11562.0, 11929.821052684216, 3824.9235015299537, 3950.9209815804097, 4367.694261401672, 4460.0, 4515.796789144496, 965.2229954886384, 967.9177269932135, 977.1449981266392, 983.341161421849, 985.0838719990478, 19292.517687057654, 19585.314513991943, 19598.0, 19807.306744263882, 20024.49938751543, 1033.3489901362093, 1038.2298181600354, 1040.4641609571077, 1041.5833666533447, 1050.3426331381618, 10576.682699519026, 10726.839097413545, 10997.945010274898, 11078.778424431466, 11151.052160566443, 437817.0, 448779.0, 462872.0, 469582.0, 469897.0, 113776.0, 114185.0, 115489.4225528867, 115983.0, 118129.0, 1159.1190695071807, 1177.7703347847087, 1185.7450648110525, 1188.287027783323, 1190.7082764722525, 17708.380206692706, 17777.644447110728, 17780.733289000935, 17888.373906913195, 17891.642167156322, 54509.72745136249, 55033.0, 55505.44494555003, 56395.43604563902, 57784.4221557779, 71786.28213717796, 72152.27847721665, 72544.27455725586, 72917.27082729105, 73549.63225184054, 19266.903665481583, 19926.90036549808, 19961.0, 19994.100265488378, 20032.098555564742, 21858.67211991853, 22307.330780076623, 22332.33003009912, 22380.77619223787, 22428.551428971004, 16370.75443868319, 16576.66846663084, 16838.0, 16863.66272674515, 17017.064061476736, 15806.783761358494, 16328.183590820649, 16579.0, 16988.320467181173, 17008.659826803643, 15144.242787860783, 15821.604459888595, 15857.286422111263, 16079.598010049842, 16099.597510062342, 19310.903445482683, 19333.323333683253, 19419.8058019418, 19527.70708439346, 19809.40571782849, 15795.36818527246, 15865.603359916095, 15883.52349429519, 16002.279897404413, 16015.91992040079], "value": 12668.124751498577, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.9199048057117, 1399.8950078744097, 1407.3244842475606, 1416.6883285677147, 1417.2346932656367, 12537.749245015095, 13234.205947643137, 13235.933820330896, 15447.30487128079, 15785.60535986601, 15271.618209544738, 15577.0, 15582.766258506132, 15583.92208038961, 15584.0, 2682.3160094176005, 2725.1143378402, 2726.481968426003, 2729.1539622717023, 2729.7952653550965, 2682.597610358452, 2737.397772490049, 2786.860656967154, 2789.497890379731, 2805.074325472589, 2737.671479422472, 2791.5673070673975, 2791.9022834200705, 2792.4833905727505, 2793.329600895791, 2668.533006723825, 2673.8262012969194, 2680.6515153030077, 2718.6329845470805, 2721.4557088582164, 2600.2849216465625, 2624.7637712605956, 2628.1983994881552, 2630.6974697909795, 2648.20553833851, 14879.256037198096, 14959.0, 14999.775003374958, 15005.174715390649, 15021.948463607552, 8022.759317220492, 8256.83486330276, 8287.751367458986, 8292.04641466233, 8316.667333306661, 5414.40441551429, 5468.890622187574, 5546.112621980464, 5567.777288908439, 5646.915296270559, 1876.5644282124185, 1897.0799162406222, 1898.8291053805224, 1961.4213806926991, 1965.2433812981963, 26648.86675566629, 27376.315592110157, 27405.86297068522, 27409.17772466829, 27431.314217144532, 7144.821379465451, 7350.669219885118, 7441.739539116105, 7489.28851759082, 7513.962430187923, 20842.0, 20887.68668469974, 20887.79112208889, 20892.686609700868, 20925.37223883286, 8074.515529068275, 8217.630206640715, 8238.134995825472, 8247.670093196324, 8345.123762005023, 6859.211190713132, 6950.54821436605, 7074.292570742988, 7093.9359096135995, 7393.704251829974, 5613.831585052455, 5701.885962280731, 5782.190493330937, 5792.333881603585, 5817.7382017809305, 1637.7134001549682, 1696.7030769615515, 1760.3046796515305, 1838.264694122335, 1863.3850829226324, 906.8503696890072, 923.7413524213231, 931.743770463128, 933.7385532051037, 937.2829785214317, 8717.433366831136, 8760.649574017096, 8780.736577902673, 8785.428947118417, 8950.104989500998, 992.9205663546899, 999.2256001598819, 1004.9748756281151, 1005.653049697853, 1017.3133135133755, 4708.411448568929, 4782.545658162469, 5472.097103977799, 5584.385717571064, 5594.552435805126, 20904.268350607657, 21117.366479005654, 21796.0, 21820.127194912344, 21898.89050554737, 21090.683639745417, 21312.254071107436, 21823.67264491034, 21970.121195152016, 21983.23058692938, 11506.021988130935, 11647.708807279885, 11658.76682466363, 11664.6500604982, 11693.590724324778, 8545.700900468453, 8750.431221970552, 8751.124887511452, 8787.34094942869, 8803.515806630441, 18214.45356639303, 18578.628427431646, 18794.15426305847, 18964.241430343183, 19022.0, 19401.70897436568, 19436.514087147934, 19439.3196238131, 19588.608227835648, 19774.30789922346, 12037.518499259932, 12282.508699651913, 12367.072469564639, 12376.319302438093, 12425.0, 12995.480180792661, 13043.673908152372, 13193.472261109448, 13205.93397033047, 13219.074664773374, 11290.830637540608, 11506.597269095542, 11636.709082273012, 11772.52909883595, 12014.63956081319, 11107.777844443228, 11119.444027798416, 11285.21003529745, 11339.489722962322, 11481.770364592829, 9859.408435493893, 9882.4564648945, 9897.65358212459, 10023.298369114093, 10062.597496100367, 7513.098428188652, 7570.16728159913, 7586.506877052974, 7595.392368610387, 7742.496737712031, 7560.3573696236435, 7607.23927607257, 7666.501677390952, 7669.5398276103615, 7827.412944029106], "value": 6865.98178319551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.7747679759304, 524.7612336386943, 530.2337084209224, 535.582245848238, 554.2268535393126, 6091.177691011718, 6192.845178870531, 6195.969020154893, 6234.251889773228, 6264.780732674358, 6152.0, 6162.0, 6162.691865406723, 6176.907346389797, 6201.565890387675, 5171.146760784466, 5199.324087868572, 5200.141976573861, 5206.24509446131, 5226.8693282667855, 4834.081524510332, 4892.828750993716, 5076.01017801527, 5085.821996230133, 5193.818216362428, 4881.731504767236, 4887.16918123918, 4898.387701537308, 4932.0, 4943.555080042795, 4876.463589005207, 4885.975570122127, 4933.432655244657, 4938.580220681229, 4974.87562810929, 4294.441722576076, 4435.401220835178, 4444.0, 4451.332300154971, 4466.441694788152, 5905.734241959122, 5937.376575459601, 5981.282246130449, 6006.429389208019, 6039.792041591655, 5578.374056863031, 5588.86027849303, 5606.607537472338, 5627.352854421753, 5656.963493142465, 6341.334159913189, 6417.582857114319, 6421.678916054178, 6483.481321494316, 6493.902591461132, 4639.652026098056, 4898.755062246909, 4911.091448082117, 4919.975400123012, 4920.3357546731095, 6480.31956644555, 6521.771737989147, 6696.2299335576545, 6754.662266886685, 6763.289854565298, 4998.975005124951, 5001.24981252815, 5009.073321435546, 5011.448740638527, 5014.398272207359, 5059.671121377099, 5100.158473851773, 5112.309838171874, 5125.513076257749, 5133.486651334912, 5667.943320566742, 5687.914681279784, 5699.860027994418, 5706.115552089433, 5706.115552089433, 6434.101939927733, 6447.70985305653, 6481.384268494486, 6485.383888530677, 6488.935110648833, 1710.7340567979854, 1739.0869793358588, 1740.382164331644, 1742.9912850435667, 1751.5621094726318, 943.3208090175063, 1231.4273862653909, 1232.280968049566, 1241.7951038078616, 1254.2349167008117, 5540.36285827135, 5565.332160140809, 5567.526760225426, 5616.427400327915, 5630.662160270397, 6515.4787616990525, 6558.360409897526, 6578.5395022347975, 6639.136912201479, 6648.66756662165, 5581.214011516276, 5607.495325420732, 5619.325680918234, 5623.606347555632, 5638.182463542763, 3472.808995505221, 3482.3209474152295, 3511.2450823073164, 3521.0845180252804, 3530.4174811156386, 6350.142730731384, 6352.443651305367, 6379.425851673279, 6409.807705768834, 6457.709403076873, 6692.0, 6700.162479690039, 6706.865862682719, 6712.228093769181, 6733.6296503692765, 6361.236651601653, 6373.267074286424, 6399.848027355028, 6411.647359395278, 6455.61266324022, 5912.970435147797, 6458.321876203119, 6546.149000629887, 6599.0, 6617.569857959217, 6292.779752708633, 6393.009083592051, 6434.292227855026, 6499.350064993463, 6550.213974323112, 6263.311035785969, 6337.271213810286, 6351.237851457855, 6358.809235722936, 6364.459020983269, 4841.685290456109, 4957.100096443477, 4958.528939750718, 4967.925481117858, 4984.277279794337, 6309.413140612327, 6408.775692850728, 6462.644554549357, 6604.339566043357, 6657.234418041987, 6164.075388691553, 6301.771154624804, 6320.367963203643, 6327.873442531031, 6330.9237429638, 6229.750809967551, 6352.237731472253, 6360.586561873463, 6360.77737279193, 6363.459105976044, 6250.718717657625, 6271.3415091414745, 6292.716827742671, 6309.589876658002, 6316.368363163647, 6321.468714874485, 6323.6838158090995, 6352.523560733056, 6358.809235722936, 6391.0, 6077.604955678044, 6111.472131967008, 6150.354212807591, 6153.169322141453, 6166.845828854314], "value": 4977.942736318103, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.197933838883, 908.7273817854643, 928.3455164109304, 936.4474959773733, 950.672018153737, 19066.0, 19653.50866228345, 19731.60536789265, 19731.704024439645, 19732.704009439833, 17801.0, 17885.374011909586, 18127.81872181278, 19607.705884411746, 19759.604807903834, 980.3970558106766, 982.7837875667342, 983.9704808855746, 985.4333758089092, 985.6895078050392, 956.5982287439257, 985.8816941966974, 988.9258305627071, 989.2975987049203, 989.3025417080977, 1048.3133547526381, 1048.6644273832376, 1050.03921411908, 1051.6844946516053, 1052.2423854824515, 1032.050513527549, 1038.6001389465073, 1041.656253436364, 1041.906228439444, 1047.9423631700254, 765.2271206081841, 765.8200322924108, 766.8427972265672, 770.3913908012663, 774.6281784743298, 20029.09869055896, 20078.0, 20227.898860505604, 20343.49141271465, 20467.795322046888, 21599.0, 21662.89168554163, 22214.777852221596, 22233.11067557312, 22239.777602224094, 17779.0, 17779.377721779805, 17830.643387132186, 17879.910600447045, 17925.103744812837, 3565.0, 3602.2975519773654, 3609.62098979606, 3628.2380700053022, 3633.255182687543, 141218.2939085298, 141982.0, 142100.28949855184, 143969.0, 144411.27794361065, 16789.664206716043, 16921.40775072891, 17470.30118795234, 17490.125493725263, 17528.73706894372, 30744.84627576848, 30755.384892302027, 30774.84612576923, 30867.845660771553, 30925.845370773, 8918.420302680304, 8932.687355942511, 8982.191602755784, 8990.415622984485, 9032.729018129467, 4041.2725709372594, 4050.1899620075515, 4091.1817636472824, 4134.111166099303, 4136.772477513766, 5347.759350829222, 5362.51737343641, 5390.784368625211, 5446.046941785172, 5454.672719636835, 945.9858102128474, 952.9285303602257, 969.1858838575489, 973.4110862927968, 974.4737841565475, 652.915121034272, 675.5473832532215, 685.8456847209437, 690.0167261652126, 694.1565997313288, 10750.248616989873, 10798.0, 11425.428728563538, 12093.516259349528, 12265.57070502528, 693.9653017349112, 700.4851434195862, 702.3222590200481, 708.9539179953287, 710.9537880037781, 5502.614816962774, 5510.264266755959, 5562.499375056264, 5635.633683810539, 5678.176664383641, 115875.0, 121322.0, 121544.0, 122762.0, 124091.3795431017, 109367.0, 109772.0, 111117.0, 112969.0, 113723.43138284255, 88307.558462206, 89298.0, 92151.0784892156, 92516.0, 92899.53550232206, 10319.690409287734, 10362.948185259025, 10384.532696028546, 10418.895811041793, 10462.581496740046, 43635.0, 43975.78012109919, 44296.55703443053, 46461.53538464572, 46484.7675761619, 56733.71633141808, 56828.71585642211, 57529.13706294325, 57580.71209643925, 58502.414975851396, 16094.597635059217, 16448.663328100967, 16490.422835200712, 16624.168791560132, 16675.082870442242, 16607.252673629475, 16670.666586667958, 16738.58153546171, 16748.330066797193, 16826.915865420593, 16616.916915415346, 16637.251323690703, 16814.327426902786, 16919.830801691827, 16936.57658558546, 14727.631809204855, 14963.34864012684, 14994.2502874858, 15047.473338433103, 15146.394144234107, 16612.916935415727, 16651.83348166551, 16671.333146674, 16814.327426902786, 17112.229949652046, 10948.945255273673, 11014.724631884266, 11046.392448415414, 11108.944455277671, 11274.37990910475, 11527.374642173543, 11684.357360344922, 11722.58970936013, 11898.940505297418, 12057.879421205676], "value": 8936.588931229135, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1434.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 108.0, 108.0, 108.0, 108.0, 110.0, 109.0, 107.0, 107.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 117.0, 115.0, 121.0, 116.0, 119.0, 115.0, 143.0, 120.0], "value": 120.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 164.0, 162.0, 163.0, 164.0, 168.0, 167.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 74.0, 74.0, 75.0, 75.0, 74.0, 74.0, 74.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 80.0, 80.0, 80.0, 80.0, 81.0, 80.0, 79.0, 80.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 118.0, 116.0, 117.0, 117.0, 118.0, 116.0, 114.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 148.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 100.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 54.0, 54.0, 55.0, 56.0, 54.0, 53.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 38.0, 41.0, 39.0, 38.0, 39.0, 38.0, 39.0, 38.0, 39.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 75.0, 77.0, 78.0, 74.0, 72.0, 73.0, 72.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 110.0, 120.0, 116.0, 120.0, 117.0, 112.0, 118.0, 119.0], "value": 117.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 169.0, 174.0, 175.0, 177.0, 169.0, 182.0, 183.0, 176.0, 171.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 64.0, 72.0, 65.0, 66.0, 75.0, 67.0], "value": 67.4, "unit": "score"}]}]} 17:57:41 INFO - Return code: 0 17:57:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:57:41 INFO - # TBPL SUCCESS # 17:57:41 INFO - Running post-action listener: _package_coverage_data 17:57:41 INFO - Running post-action listener: _resource_record_post_action 17:57:41 INFO - [mozharness: 2017-09-26 00:57:41.131431Z] Finished run-tests step (success) 17:57:41 INFO - Running post-run listener: _resource_record_post_run 17:57:41 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 9457664; Write bytes: 452898816; Read time: 3276; Write time: 450112 17:57:41 INFO - TinderboxPrint: CPU usage
13.1% 17:57:41 INFO - TinderboxPrint: I/O read bytes / time
9,457,664 / 3,276 17:57:41 INFO - TinderboxPrint: I/O write bytes / time
452,898,816 / 450,112 17:57:41 INFO - TinderboxPrint: CPU idle
8,245.3 (86.8%) 17:57:41 INFO - TinderboxPrint: CPU user
1,191.8 (12.6%) 17:57:41 INFO - TinderboxPrint: Swap in / out
0 / 0 17:57:41 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 663552; Read time: 0; Write time: 56 17:57:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:57:41 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 7327744; Write bytes: 409194496; Read time: 2804; Write time: 430788 17:57:41 INFO - Running post-run listener: _upload_blobber_files 17:57:41 INFO - Blob upload gear active. 17:57:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:57:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:57:42 INFO - (blobuploader) - INFO - Open directory for files ... 17:57:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:57:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:57:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:43 INFO - (blobuploader) - INFO - Done attempting. 17:57:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:57:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:57:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:49 INFO - (blobuploader) - INFO - Done attempting. 17:57:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:57:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:57:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:50 INFO - (blobuploader) - INFO - Done attempting. 17:57:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:57:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:57:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:51 INFO - (blobuploader) - INFO - Done attempting. 17:57:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:57:51 INFO - Return code: 0 17:57:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:57:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:57:51 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d80d84a18eca88eea66a2f505073a51c9925908990ef5937d7b3dd714b40a2234b1f80358ebc82be1a120ea9bb329b5758f0626e0225e3a020e6dc64fb5403d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe7392e97bf56d44da5df0e0235f5bdf4af72c0d8a0658eb5c46fac298fa6d2ac3bff9ac2e9dff326711f02bd95421a9c5742dcf8d683d28529267bfdc1adc80", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/348690707be435d12433a08fc34e90529d04ad9ea5133a81a055847d6318512512a69944e2ba6099130fdb74ef0c5ce275aec9b1c5b93a3ded27c3ae716dc1c1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df41260886afc9ba0ceb6c9aa289f92468e520e3c89d4cf05085bc2438295838314b2e54af6c38fc58046abd59e7ffb7aec8d7e7be2e8f630b0e2038926450ee"} 17:57:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:57:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:57:51 INFO - Contents: 17:57:51 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d80d84a18eca88eea66a2f505073a51c9925908990ef5937d7b3dd714b40a2234b1f80358ebc82be1a120ea9bb329b5758f0626e0225e3a020e6dc64fb5403d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe7392e97bf56d44da5df0e0235f5bdf4af72c0d8a0658eb5c46fac298fa6d2ac3bff9ac2e9dff326711f02bd95421a9c5742dcf8d683d28529267bfdc1adc80", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/348690707be435d12433a08fc34e90529d04ad9ea5133a81a055847d6318512512a69944e2ba6099130fdb74ef0c5ce275aec9b1c5b93a3ded27c3ae716dc1c1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df41260886afc9ba0ceb6c9aa289f92468e520e3c89d4cf05085bc2438295838314b2e54af6c38fc58046abd59e7ffb7aec8d7e7be2e8f630b0e2038926450ee"} 17:57:51 INFO - Running post-run listener: copy_logs_to_upload_dir 17:57:51 INFO - Copying logs to upload dir... 17:57:51 INFO - mkdir: /builds/slave/test/build/upload/logs 17:57:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.371197 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-25 17:57:51.946644) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 17:57:51.952312) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d80d84a18eca88eea66a2f505073a51c9925908990ef5937d7b3dd714b40a2234b1f80358ebc82be1a120ea9bb329b5758f0626e0225e3a020e6dc64fb5403d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe7392e97bf56d44da5df0e0235f5bdf4af72c0d8a0658eb5c46fac298fa6d2ac3bff9ac2e9dff326711f02bd95421a9c5742dcf8d683d28529267bfdc1adc80", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/348690707be435d12433a08fc34e90529d04ad9ea5133a81a055847d6318512512a69944e2ba6099130fdb74ef0c5ce275aec9b1c5b93a3ded27c3ae716dc1c1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df41260886afc9ba0ceb6c9aa289f92468e520e3c89d4cf05085bc2438295838314b2e54af6c38fc58046abd59e7ffb7aec8d7e7be2e8f630b0e2038926450ee"} build_url:https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/YCRCLS0WQIqLyHDorScFGQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d80d84a18eca88eea66a2f505073a51c9925908990ef5937d7b3dd714b40a2234b1f80358ebc82be1a120ea9bb329b5758f0626e0225e3a020e6dc64fb5403d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe7392e97bf56d44da5df0e0235f5bdf4af72c0d8a0658eb5c46fac298fa6d2ac3bff9ac2e9dff326711f02bd95421a9c5742dcf8d683d28529267bfdc1adc80", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/348690707be435d12433a08fc34e90529d04ad9ea5133a81a055847d6318512512a69944e2ba6099130fdb74ef0c5ce275aec9b1c5b93a3ded27c3ae716dc1c1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df41260886afc9ba0ceb6c9aa289f92468e520e3c89d4cf05085bc2438295838314b2e54af6c38fc58046abd59e7ffb7aec8d7e7be2e8f630b0e2038926450ee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 17:57:51.980384) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:57:51.980705) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1506386226.731158-1897460363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004380 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:57:52.063903) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 17:57:52.064230) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 17:57:52.064556) ========= ========= Total master_lag: 0.21 =========