builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-030 starttime: 1506991769.65 results: success (0) revision: 65dac33a5682f3ec5a675e7f3314b0c1520a13fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:29.648760) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:29.649428) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:29.649698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:29.692988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:29.693340) ========= 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=3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 17:49:29-- 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% 24.4M=0s 2017-10-02 17:49:29 (24.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090480 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:29.803686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:29.803970) ========= 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=3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016497 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:29.854347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:29.854634) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 65dac33a5682f3ec5a675e7f3314b0c1520a13fa --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 65dac33a5682f3ec5a675e7f3314b0c1520a13fa --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=3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 17:49:29,908 truncating revision to first 12 chars 2017-10-02 17:49:29,908 Setting DEBUG logging. 2017-10-02 17:49:29,908 attempt 1/10 2017-10-02 17:49:29,908 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/65dac33a5682?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 17:49:30,207 unpacking tar archive at: mozilla-central-65dac33a5682/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579878 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:30.451075) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:30.451372) ========= script_repo_revision: 65dac33a5682f3ec5a675e7f3314b0c1520a13fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:30.451736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:30.452006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 17:49:30.467314) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-10-02 17:49:30.467571) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:49:30 INFO - MultiFileLogger online at 20171002 17:49:30 in /builds/slave/test 17:49:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:49:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:49:30 INFO - {'append_to_log': False, 17:49:30 INFO - 'base_work_dir': '/builds/slave/test', 17:49:30 INFO - 'blob_upload_branch': 'Firefox', 17:49:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:49:30 INFO - 'branch': 'Firefox', 17:49:30 INFO - 'buildbot_json_path': 'buildprops.json', 17:49:30 INFO - 'code_coverage': False, 17:49:30 INFO - 'config_files': ('talos/linux_config.py',), 17:49:30 INFO - 'default_actions': ('clobber', 17:49:30 INFO - 'read-buildbot-config', 17:49:30 INFO - 'download-and-extract', 17:49:30 INFO - 'populate-webroot', 17:49:30 INFO - 'create-virtualenv', 17:49:30 INFO - 'install', 17:49:30 INFO - 'setup-mitmproxy', 17:49:30 INFO - 'run-tests'), 17:49:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:49:30 INFO - 'disable_ccov_upload': False, 17:49:30 INFO - 'disable_stylo': False, 17:49:30 INFO - 'download_minidump_stackwalk': True, 17:49:30 INFO - 'download_symbols': 'ondemand', 17:49:30 INFO - 'enable_stylo': False, 17:49:30 INFO - 'enable_webrender': False, 17:49:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:49:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:49:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:49:30 INFO - 'gecko_profile': False, 17:49:30 INFO - 'gecko_profile_interval': 0, 17:49:30 INFO - 'installer_path': 'installer.exe', 17:49:30 INFO - 'log_level': 'info', 17:49:30 INFO - 'log_name': 'talos', 17:49:30 INFO - 'log_to_console': True, 17:49:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:49:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:49:30 INFO - 'opt_config_files': (), 17:49:30 INFO - 'pip_index': False, 17:49:30 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:49:30 INFO - 'system_bits': '32', 17:49:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:49:30 INFO - 'title': 'talos-linux64-ix-030', 17:49:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:49:30 INFO - 'use_talos_json': True, 17:49:30 INFO - 'verify': 'False', 17:49:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:49:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:49:30 INFO - 'work_dir': 'build'} 17:49:30 INFO - [mozharness: 2017-10-03 00:49:30.660564Z] Running clobber step. 17:49:30 INFO - Running pre-action listener: _resource_record_pre_action 17:49:30 INFO - Running main action method: clobber 17:49:30 INFO - rmtree: /builds/slave/test/build 17:49:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:49:31 INFO - Running post-action listener: _resource_record_post_action 17:49:31 INFO - [mozharness: 2017-10-03 00:49:31.659219Z] Finished clobber step (success) 17:49:31 INFO - [mozharness: 2017-10-03 00:49:31.659327Z] Running read-buildbot-config step. 17:49:31 INFO - Running pre-action listener: _resource_record_pre_action 17:49:31 INFO - Running main action method: read_buildbot_config 17:49:31 INFO - Using buildbot properties: 17:49:31 INFO - { 17:49:31 INFO - "project": "", 17:49:31 INFO - "product": "firefox", 17:49:31 INFO - "who": "kwierso@gmail.com", 17:49:31 INFO - "installer_path": "public/build/target.tar.bz2", 17:49:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:49:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:49:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 17:49:31 INFO - "stage_platform": "linux64-pgo", 17:49:31 INFO - "basedir": "/builds/slave/test", 17:49:31 INFO - "buildnumber": 8, 17:49:31 INFO - "platform": "ubuntu64_hw", 17:49:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:49:31 INFO - "slavebuilddir": "test", 17:49:31 INFO - "taskId": "XiiWfyOnT-q8KtqwLdsGxw", 17:49:31 INFO - "branch": "mozilla-central", 17:49:31 INFO - "script_repo_revision": "production", 17:49:31 INFO - "revision": "65dac33a5682f3ec5a675e7f3314b0c1520a13fa", 17:49:31 INFO - "slavename": "talos-linux64-ix-030", 17:49:31 INFO - "repo_path": "mozilla-central" 17:49:31 INFO - } 17:49:31 INFO - Finding installer, test and symbols from parent task. 17:49:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XiiWfyOnT-q8KtqwLdsGxw'}, attempt #1 17:49:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XiiWfyOnT-q8KtqwLdsGxw'}, attempt #1 17:49:32 INFO - Task dependencies: GvTuDUuVRuaZlRJDpMYY1Q 17:49:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q'}, attempt #1 17:49:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.tar.bz2 17:49:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.test_packages.json 17:49:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.crashreporter-symbols.zip 17:49:33 INFO - Running post-action listener: _resource_record_post_action 17:49:33 INFO - [mozharness: 2017-10-03 00:49:33.380127Z] Finished read-buildbot-config step (success) 17:49:33 INFO - [mozharness: 2017-10-03 00:49:33.380348Z] Running download-and-extract step. 17:49:33 INFO - Running pre-action listener: _resource_record_pre_action 17:49:33 INFO - Running main action method: download_and_extract 17:49:33 INFO - mkdir: /builds/slave/test/build/tests 17:49: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:49:33 INFO - trying https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.test_packages.json 17:49:33 INFO - Downloading https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:49:34 INFO - Downloaded 989 bytes. 17:49:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:49:34 INFO - Using the following test package requirements: 17:49:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:49:34 INFO - u'common': [u'target.common.tests.zip'], 17:49:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:49:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:49:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:49:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:49:34 INFO - u'mozbase': [u'target.common.tests.zip'], 17:49:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:49:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:49:34 INFO - u'web-platform': [u'target.common.tests.zip', 17:49:34 INFO - u'target.web-platform.tests.tar.gz'], 17:49:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:49:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:49:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.common.tests.zip 17:49:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:49:34 INFO - Fetch https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.common.tests.zip into memory 17:49:35 INFO - Content-Length response header: 55903400 17:49:35 INFO - Bytes received: 55903400 17:49:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.talos.tests.zip 17:49:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:49:46 INFO - Fetch https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.talos.tests.zip into memory 17:49:47 INFO - Content-Length response header: 14522427 17:49:47 INFO - Bytes received: 14522427 17:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:47 INFO - trying https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.tar.bz2 17:49:47 INFO - Downloading https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:49:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:49:48 INFO - Downloaded 62308381 bytes. 17:49:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.tar.bz2 17:49:48 INFO - mkdir: /builds/slave/test/properties 17:49:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:49:48 INFO - Writing to file /builds/slave/test/properties/build_url 17:49:48 INFO - Contents: 17:49:48 INFO - build_url:https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.tar.bz2 17:49:48 INFO - Running post-action listener: _resource_record_post_action 17:49:48 INFO - Running post-action listener: find_tests_for_verification 17:49:48 INFO - Running post-action listener: set_extra_try_arguments 17:49:48 INFO - [mozharness: 2017-10-03 00:49:48.954252Z] Finished download-and-extract step (success) 17:49:48 INFO - [mozharness: 2017-10-03 00:49:48.954356Z] Running populate-webroot step. 17:49:48 INFO - Running pre-action listener: _resource_record_pre_action 17:49:48 INFO - Running main action method: populate_webroot 17:49:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:49:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:49:48 INFO - 'tests': ['tresize', 17:49:48 INFO - 'tcanvasmark']}, 17:49:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:49:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:49:48 INFO - 'tests': ['dromaeo_css', 17:49:48 INFO - 'kraken']}, 17:49:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:49:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:49:48 INFO - 'talos_options': ['--disable-stylo'], 17:49:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:49:48 INFO - 'tests': ['damp', 'tps']}, 17:49:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:49:48 INFO - 'talos_options': ['--disable-stylo'], 17:49:48 INFO - 'tests': ['damp', 'tps']}, 17:49:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:49:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:49:48 INFO - 'tests': ['dromaeo_dom']}, 17:49:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:49:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:49:48 INFO - 'tests': ['basic_compositor_video', 17:49:48 INFO - 'glvideo']}, 17:49:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:49:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:49:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:49:48 INFO - 'talos_options': ['--disable-stylo'], 17:49:48 INFO - 'tests': ['ts_paint_webext', 17:49:48 INFO - 'tp5o_webext']}, 17:49:48 INFO - 'other-e10s': {'tests': ['a11yr', 17:49:48 INFO - 'ts_paint', 17:49:48 INFO - 'tpaint', 17:49:48 INFO - 'sessionrestore', 17:49:48 INFO - 'sessionrestore_many_windows', 17:49:48 INFO - 'sessionrestore_no_auto_restore', 17:49:48 INFO - 'tabpaint', 17:49:48 INFO - 'cpstartup']}, 17:49:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:49:48 INFO - 'tests': ['a11yr', 17:49:48 INFO - 'ts_paint', 17:49:48 INFO - 'tpaint', 17:49:48 INFO - 'sessionrestore', 17:49:48 INFO - 'sessionrestore_many_windows', 17:49:48 INFO - 'sessionrestore_no_auto_restore', 17:49:48 INFO - 'tabpaint', 17:49:48 INFO - 'cpstartup']}, 17:49:48 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:49:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:49:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:49:48 INFO - 'tests': ['perf_reftest_singletons']}, 17:49:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:49:48 INFO - 'tests': ['perf_reftest']}, 17:49:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:49:48 INFO - 'tsvgr_opacity', 17:49:48 INFO - 'tart', 17:49:48 INFO - 'tscrollx', 17:49:48 INFO - 'tsvg_static']}, 17:49:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:49:48 INFO - 'tests': ['tsvgx', 17:49:48 INFO - 'tsvgr_opacity', 17:49:48 INFO - 'tart', 17:49:48 INFO - 'tscrollx', 17:49:48 INFO - 'tsvg_static']}, 17:49:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:49:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:49:48 INFO - 'talos_options': ['--disable-stylo'], 17:49:48 INFO - 'tests': ['tp5o']}, 17:49:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:49:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:49:48 INFO - 'talos_options': ['--mitmproxy', 17:49:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:49:48 INFO - '--firstNonBlankPaint'], 17:49:48 INFO - 'tests': ['tp6_google', 17:49:48 INFO - 'tp6_youtube', 17:49:48 INFO - 'tp6_amazon', 17:49:48 INFO - 'tp6_facebook']}, 17:49:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:49:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:49:48 INFO - 'talos_options': ['--disable-stylo', 17:49:48 INFO - '--mitmproxy', 17:49:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:49:48 INFO - '--firstNonBlankPaint'], 17:49:48 INFO - 'tests': ['tp6_google', 17:49:48 INFO - 'tp6_youtube', 17:49:48 INFO - 'tp6_amazon', 17:49:48 INFO - 'tp6_facebook']}, 17:49:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:49:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:49:48 INFO - 'talos_options': ['--stylo-threads=1', 17:49:48 INFO - '--mitmproxy', 17:49:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:49:48 INFO - '--firstNonBlankPaint'], 17:49:48 INFO - 'tests': ['tp6_google', 17:49:48 INFO - 'tp6_youtube', 17:49:48 INFO - 'tp6_amazon', 17:49:48 INFO - 'tp6_facebook']}, 17:49:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:49:48 INFO - 'talos_options': ['--xperf_path', 17:49:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:48 INFO - 'tests': ['tp5n']}, 17:49:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:49:48 INFO - 'talos_options': ['--disable-stylo', 17:49:48 INFO - '--xperf_path', 17:49:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:48 INFO - 'tests': ['tp5n']}}} 17:49:48 INFO - Running post-action listener: _resource_record_post_action 17:49:48 INFO - [mozharness: 2017-10-03 00:49:48.975930Z] Finished populate-webroot step (success) 17:49:48 INFO - [mozharness: 2017-10-03 00:49:48.976021Z] Running create-virtualenv step. 17:49:48 INFO - Running pre-action listener: _resource_record_pre_action 17:49:48 INFO - Running main action method: create_virtualenv 17:49:48 INFO - Creating virtualenv /builds/slave/test/build/venv 17:49:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:49:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:49:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:49:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:49:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:49:49 INFO - Installing distribute.............................................................................................................................................................................................done. 17:49:49 INFO - Installing pip...............done. 17:49:49 INFO - Return code: 0 17:49:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:49:49 INFO - Reading from file tmpfile_stdout 17:49:49 INFO - Output received: 17:49:49 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:49:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:49: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:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49: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:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a12b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb79c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb4d60>, '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 0x1bb5a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5ef0>, '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': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', '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:49: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', 'pip>=1.5'] in /builds/slave/test/build 17:49: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 pip>=1.5 17:49:49 INFO - Using env: {'DISPLAY': ':0', 17:49:49 INFO - 'HOME': '/home/cltbld', 17:49:49 INFO - 'LANG': 'en_US.UTF-8', 17:49:49 INFO - 'LANGUAGE': 'en_US:en', 17:49:49 INFO - 'LOGNAME': 'cltbld', 17:49:49 INFO - 'MAIL': '/var/mail/cltbld', 17:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:49 INFO - 'MOZ_NO_REMOTE': '1', 17:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:49 INFO - 'NO_EM_RESTART': '1', 17:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:49 INFO - 'PWD': '/builds/slave/test', 17:49:49 INFO - 'SHELL': '/bin/bash', 17:49:49 INFO - 'SHLVL': '1', 17:49:49 INFO - 'TERM': 'linux', 17:49:49 INFO - 'TMOUT': '86400', 17:49:49 INFO - 'USER': 'cltbld', 17:49:49 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 17:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:49 INFO - '_': '/tools/buildbot/bin/python'} 17:49:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:49:51 INFO - Downloading/unpacking pip>=1.5 17:49:51 INFO - Running setup.py egg_info for package pip 17:49:51 INFO - warning: no files found matching 'pip/cacert.pem' 17:49:51 INFO - warning: no files found matching '*.html' under directory 'docs' 17:49:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:49:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:49:51 INFO - Installing collected packages: pip 17:49:51 INFO - Found existing installation: pip 1.1 17:49:51 INFO - Uninstalling pip: 17:49:51 INFO - Successfully uninstalled pip 17:49:51 INFO - Running setup.py install for pip 17:49:51 INFO - warning: no files found matching 'pip/cacert.pem' 17:49:51 INFO - warning: no files found matching '*.html' under directory 'docs' 17:49:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:49:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:49:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:49:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:49:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:49:51 INFO - Successfully installed pip 17:49:51 INFO - Cleaning up... 17:49:51 INFO - Return code: 0 17:49:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x184a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a12b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb79c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb4d60>, '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 0x1bb5a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5ef0>, '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': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', '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:49:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:49:51 INFO - Using env: {'DISPLAY': ':0', 17:49:51 INFO - 'HOME': '/home/cltbld', 17:49:51 INFO - 'LANG': 'en_US.UTF-8', 17:49:51 INFO - 'LANGUAGE': 'en_US:en', 17:49:51 INFO - 'LOGNAME': 'cltbld', 17:49:51 INFO - 'MAIL': '/var/mail/cltbld', 17:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:51 INFO - 'MOZ_NO_REMOTE': '1', 17:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:51 INFO - 'NO_EM_RESTART': '1', 17:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:51 INFO - 'PWD': '/builds/slave/test', 17:49:51 INFO - 'SHELL': '/bin/bash', 17:49:51 INFO - 'SHLVL': '1', 17:49:51 INFO - 'TERM': 'linux', 17:49:51 INFO - 'TMOUT': '86400', 17:49:51 INFO - 'USER': 'cltbld', 17:49:51 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 17:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:51 INFO - '_': '/tools/buildbot/bin/python'} 17:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:51 INFO - Downloading/unpacking psutil>=3.1.1 17:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:49:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:52 INFO - Installing collected packages: psutil 17:49:52 INFO - Running setup.py install for psutil 17:49:52 INFO - building 'psutil._psutil_linux' extension 17:49:52 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:49:52 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:49:52 INFO - building 'psutil._psutil_posix' extension 17:49:52 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:49:53 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:49:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:53 INFO - Successfully installed psutil 17:49:53 INFO - Cleaning up... 17:49:53 INFO - Return code: 0 17:49:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:53 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 0x184a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a12b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb79c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb4d60>, '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 0x1bb5a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5ef0>, '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': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', '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:49:53 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:49:53 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:49:53 INFO - Using env: {'DISPLAY': ':0', 17:49:53 INFO - 'HOME': '/home/cltbld', 17:49:53 INFO - 'LANG': 'en_US.UTF-8', 17:49:53 INFO - 'LANGUAGE': 'en_US:en', 17:49:53 INFO - 'LOGNAME': 'cltbld', 17:49:53 INFO - 'MAIL': '/var/mail/cltbld', 17:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:53 INFO - 'MOZ_NO_REMOTE': '1', 17:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:53 INFO - 'NO_EM_RESTART': '1', 17:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:53 INFO - 'PWD': '/builds/slave/test', 17:49:53 INFO - 'SHELL': '/bin/bash', 17:49:53 INFO - 'SHLVL': '1', 17:49:53 INFO - 'TERM': 'linux', 17:49:53 INFO - 'TMOUT': '86400', 17:49:53 INFO - 'USER': 'cltbld', 17:49:53 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 17:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:53 INFO - '_': '/tools/buildbot/bin/python'} 17:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:49:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:49:54 INFO - Installing collected packages: mozsystemmonitor 17:49:54 INFO - Running setup.py install for mozsystemmonitor 17:49:54 INFO - Successfully installed mozsystemmonitor 17:49:54 INFO - Cleaning up... 17:49:55 INFO - Return code: 0 17:49:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:49:55 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:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:55 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:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:55 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 0x184a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a12b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb79c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb4d60>, '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 0x1bb5a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5ef0>, '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': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', '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:49:55 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:49:55 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:49:55 INFO - Using env: {'DISPLAY': ':0', 17:49:55 INFO - 'HOME': '/home/cltbld', 17:49:55 INFO - 'LANG': 'en_US.UTF-8', 17:49:55 INFO - 'LANGUAGE': 'en_US:en', 17:49:55 INFO - 'LOGNAME': 'cltbld', 17:49:55 INFO - 'MAIL': '/var/mail/cltbld', 17:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:55 INFO - 'MOZ_NO_REMOTE': '1', 17:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:55 INFO - 'NO_EM_RESTART': '1', 17:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:55 INFO - 'PWD': '/builds/slave/test', 17:49:55 INFO - 'SHELL': '/bin/bash', 17:49:55 INFO - 'SHLVL': '1', 17:49:55 INFO - 'TERM': 'linux', 17:49:55 INFO - 'TMOUT': '86400', 17:49:55 INFO - 'USER': 'cltbld', 17:49:55 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 17:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:55 INFO - '_': '/tools/buildbot/bin/python'} 17:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:55 INFO - Downloading/unpacking jsonschema==2.5.1 17:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:49:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:57 INFO - Downloading functools32-3.2.3-2.tar.gz 17:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:49:57 INFO - warning: no files found matching '*.txt' 17:49:57 INFO - no previously-included directories found matching 'build' 17:49:57 INFO - no previously-included directories found matching 'dist' 17:49:57 INFO - no previously-included directories found matching '.git*' 17:49:57 INFO - Installing collected packages: jsonschema, functools32 17:49:57 INFO - Running setup.py install for functools32 17:49:57 INFO - warning: no files found matching '*.txt' 17:49:57 INFO - no previously-included directories found matching 'build' 17:49:57 INFO - no previously-included directories found matching 'dist' 17:49:57 INFO - no previously-included directories found matching '.git*' 17:49:57 INFO - Successfully installed jsonschema functools32 17:49:57 INFO - Cleaning up... 17:49:57 INFO - Return code: 0 17:49:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x184a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a12b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb79c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb4d60>, '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 0x1bb5a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5ef0>, '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': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', '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:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:49:57 INFO - Using env: {'DISPLAY': ':0', 17:49:57 INFO - 'HOME': '/home/cltbld', 17:49:57 INFO - 'LANG': 'en_US.UTF-8', 17:49:57 INFO - 'LANGUAGE': 'en_US:en', 17:49:57 INFO - 'LOGNAME': 'cltbld', 17:49:57 INFO - 'MAIL': '/var/mail/cltbld', 17:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:57 INFO - 'MOZ_NO_REMOTE': '1', 17:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:57 INFO - 'NO_EM_RESTART': '1', 17:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:57 INFO - 'PWD': '/builds/slave/test', 17:49:57 INFO - 'SHELL': '/bin/bash', 17:49:57 INFO - 'SHLVL': '1', 17:49:57 INFO - 'TERM': 'linux', 17:49:57 INFO - 'TMOUT': '86400', 17:49:57 INFO - 'USER': 'cltbld', 17:49:57 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 17:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:57 INFO - '_': '/tools/buildbot/bin/python'} 17:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:49:57 INFO - Cleaning up... 17:49:57 INFO - Return code: 0 17:49:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x184a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a12b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb79c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb4d60>, '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 0x1bb5a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5ef0>, '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': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', '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:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:49:57 INFO - Using env: {'DISPLAY': ':0', 17:49:57 INFO - 'HOME': '/home/cltbld', 17:49:57 INFO - 'LANG': 'en_US.UTF-8', 17:49:57 INFO - 'LANGUAGE': 'en_US:en', 17:49:57 INFO - 'LOGNAME': 'cltbld', 17:49:57 INFO - 'MAIL': '/var/mail/cltbld', 17:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:57 INFO - 'MOZ_NO_REMOTE': '1', 17:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:57 INFO - 'NO_EM_RESTART': '1', 17:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:57 INFO - 'PWD': '/builds/slave/test', 17:49:57 INFO - 'SHELL': '/bin/bash', 17:49:57 INFO - 'SHLVL': '1', 17:49:57 INFO - 'TERM': 'linux', 17:49:57 INFO - 'TMOUT': '86400', 17:49:57 INFO - 'USER': 'cltbld', 17:49:57 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 17:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:57 INFO - '_': '/tools/buildbot/bin/python'} 17:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:58 INFO - Downloading/unpacking blobuploader==1.2.4 17:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:59 INFO - Downloading blobuploader-1.2.4.tar.gz 17:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:49:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:49:59 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:49:59 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:49:59 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:49:59 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:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:49:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:49:59 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:49:59 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:49:59 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:49:59 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:49:59 INFO - Downloading docopt-0.6.1.tar.gz 17:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:49:59 INFO - Installing collected packages: blobuploader, requests, docopt 17:49:59 INFO - Running setup.py install for blobuploader 17:49:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:49:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:49:59 INFO - Running setup.py install for requests 17:50:00 INFO - Running setup.py install for docopt 17:50:00 INFO - Successfully installed blobuploader requests docopt 17:50:00 INFO - Cleaning up... 17:50:00 INFO - Return code: 0 17:50:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:00 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 0x184a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a12b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb79c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb4d60>, '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 0x1bb5a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5ef0>, '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': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', '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:50:00 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:50:00 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:50:00 INFO - Using env: {'DISPLAY': ':0', 17:50:00 INFO - 'HOME': '/home/cltbld', 17:50:00 INFO - 'LANG': 'en_US.UTF-8', 17:50:00 INFO - 'LANGUAGE': 'en_US:en', 17:50:00 INFO - 'LOGNAME': 'cltbld', 17:50:00 INFO - 'MAIL': '/var/mail/cltbld', 17:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:00 INFO - 'MOZ_NO_REMOTE': '1', 17:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:00 INFO - 'NO_EM_RESTART': '1', 17:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:00 INFO - 'PWD': '/builds/slave/test', 17:50:00 INFO - 'SHELL': '/bin/bash', 17:50:00 INFO - 'SHLVL': '1', 17:50:00 INFO - 'TERM': 'linux', 17:50:00 INFO - 'TMOUT': '86400', 17:50:00 INFO - 'USER': 'cltbld', 17:50:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 17:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:00 INFO - '_': '/tools/buildbot/bin/python'} 17:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:50:00 INFO - Running setup.py (path:/tmp/pip-MdJgwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:50:00 INFO - Running setup.py (path:/tmp/pip-D_DhmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:50:00 INFO - Running setup.py (path:/tmp/pip-eXxaGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:50:00 INFO - Running setup.py (path:/tmp/pip-VO4wEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:50:00 INFO - Running setup.py (path:/tmp/pip-hPht3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:50:00 INFO - Running setup.py (path:/tmp/pip-7N0TlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:50:01 INFO - Running setup.py (path:/tmp/pip-A8YmUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:50:01 INFO - Running setup.py (path:/tmp/pip-xzNW28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:50:01 INFO - Running setup.py (path:/tmp/pip-1ayRmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:50:01 INFO - Running setup.py (path:/tmp/pip-Eu71mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:50:01 INFO - Running setup.py (path:/tmp/pip-gLBu4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:50:01 INFO - Running setup.py (path:/tmp/pip-dO0onk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:50:01 INFO - Running setup.py (path:/tmp/pip-N25eia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:50:01 INFO - Running setup.py (path:/tmp/pip-W9jPXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:01 INFO - Running setup.py (path:/tmp/pip-Rq9pYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:50:01 INFO - Running setup.py (path:/tmp/pip-5rAjmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:50:01 INFO - Running setup.py (path:/tmp/pip-FjON9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:50:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:50:01 INFO - Running setup.py install for manifestparser 17:50:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:50:01 INFO - Running setup.py install for mozcrash 17:50:01 INFO - Running setup.py install for mozdebug 17:50:02 INFO - Running setup.py install for mozdevice 17:50:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:50:02 INFO - Running setup.py install for mozfile 17:50:02 INFO - Running setup.py install for mozhttpd 17:50:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:50:02 INFO - Running setup.py install for mozinfo 17:50:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:50:02 INFO - Running setup.py install for mozInstall 17:50:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:50:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:50:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:50:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:50:02 INFO - Running setup.py install for mozleak 17:50:02 INFO - Running setup.py install for mozlog 17:50:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:50:02 INFO - Running setup.py install for moznetwork 17:50:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:50:02 INFO - Running setup.py install for mozprocess 17:50:03 INFO - Running setup.py install for mozprofile 17:50:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:50:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:50:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:50:03 INFO - Running setup.py install for mozrunner 17:50:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:50:03 INFO - Running setup.py install for mozscreenshot 17:50:03 INFO - Running setup.py install for moztest 17:50:03 INFO - Running setup.py install for mozversion 17:50:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:50:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:50:03 INFO - Cleaning up... 17:50:03 INFO - Return code: 0 17:50:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:03 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:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:03 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:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:03 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 0x184a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a12b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb79c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb4d60>, '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 0x1bb5a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5ef0>, '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': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', '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:50:03 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:50:03 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:50:03 INFO - Using env: {'DISPLAY': ':0', 17:50:03 INFO - 'HOME': '/home/cltbld', 17:50:03 INFO - 'LANG': 'en_US.UTF-8', 17:50:03 INFO - 'LANGUAGE': 'en_US:en', 17:50:03 INFO - 'LOGNAME': 'cltbld', 17:50:03 INFO - 'MAIL': '/var/mail/cltbld', 17:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:03 INFO - 'MOZ_NO_REMOTE': '1', 17:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:03 INFO - 'NO_EM_RESTART': '1', 17:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:03 INFO - 'PWD': '/builds/slave/test', 17:50:03 INFO - 'SHELL': '/bin/bash', 17:50:03 INFO - 'SHLVL': '1', 17:50:03 INFO - 'TERM': 'linux', 17:50:03 INFO - 'TMOUT': '86400', 17:50:03 INFO - 'USER': 'cltbld', 17:50:03 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 17:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:03 INFO - '_': '/tools/buildbot/bin/python'} 17:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:50:03 INFO - Running setup.py (path:/tmp/pip-ic6oJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:50:03 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:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:50:03 INFO - Running setup.py (path:/tmp/pip-Flsdz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:50:03 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:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:50:03 INFO - Running setup.py (path:/tmp/pip-PHUuId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:50:03 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:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:50:03 INFO - Running setup.py (path:/tmp/pip-o47cg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:50:04 INFO - Running setup.py (path:/tmp/pip-GQHhfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:50:04 INFO - Running setup.py (path:/tmp/pip-06U1J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:50:04 INFO - Running setup.py (path:/tmp/pip-uSnAXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:50:04 INFO - Running setup.py (path:/tmp/pip-2CXvsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:50:04 INFO - Running setup.py (path:/tmp/pip-Jnybs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:50:04 INFO - Running setup.py (path:/tmp/pip-s5Y8Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:50:04 INFO - Running setup.py (path:/tmp/pip-MIqWrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:50:04 INFO - Running setup.py (path:/tmp/pip-MzLmgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:50:04 INFO - Running setup.py (path:/tmp/pip-o9RcPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:50:04 INFO - Running setup.py (path:/tmp/pip-XwVLC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:04 INFO - Running setup.py (path:/tmp/pip-VJPkoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:50:04 INFO - Running setup.py (path:/tmp/pip-cz_FoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:50:04 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:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:50:04 INFO - Running setup.py (path:/tmp/pip-_zy2rW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:50:04 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:50:04 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:50:04 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:50:04 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:50:04 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:50:04 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:50:04 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:50:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:50:05 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:50:05 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:50:05 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:50:05 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:50:06 INFO - Downloading blessings-1.6.tar.gz 17:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:50:06 INFO - Installing collected packages: blessings 17:50:06 INFO - Running setup.py install for blessings 17:50:06 INFO - Successfully installed blessings 17:50:06 INFO - Cleaning up... 17:50:06 INFO - Return code: 0 17:50:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:06 INFO - Reading from file tmpfile_stdout 17:50:06 INFO - Current package versions: 17:50:06 INFO - argparse == 1.2.1 17:50:06 INFO - blessings == 1.6 17:50:06 INFO - blobuploader == 1.2.4 17:50:06 INFO - docopt == 0.6.1 17:50:06 INFO - functools32 == 3.2.3-2 17:50:06 INFO - jsonschema == 2.5.1 17:50:06 INFO - manifestparser == 1.1 17:50:06 INFO - mozInstall == 1.13 17:50:06 INFO - mozcrash == 1.0 17:50:06 INFO - mozdebug == 0.1 17:50:06 INFO - mozdevice == 0.51 17:50:06 INFO - mozfile == 1.2 17:50:06 INFO - mozhttpd == 0.7 17:50:06 INFO - mozinfo == 0.10 17:50:06 INFO - mozleak == 0.1 17:50:06 INFO - mozlog == 3.5 17:50:06 INFO - moznetwork == 0.27 17:50:06 INFO - mozprocess == 0.25 17:50:06 INFO - mozprofile == 0.28 17:50:06 INFO - mozrunner == 6.13 17:50:06 INFO - mozscreenshot == 0.1 17:50:06 INFO - mozsystemmonitor == 0.3 17:50:06 INFO - moztest == 0.8 17:50:06 INFO - mozversion == 1.4 17:50:06 INFO - psutil == 3.1.1 17:50:06 INFO - requests == 1.2.3 17:50:06 INFO - wsgiref == 0.1.2 17:50:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:06 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:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:06 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:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:06 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 0x184a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a12b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb79c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb4d60>, '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 0x1bb5a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5ef0>, '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': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', '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:50:06 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:50:06 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:50:06 INFO - Using env: {'DISPLAY': ':0', 17:50:06 INFO - 'HOME': '/home/cltbld', 17:50:06 INFO - 'LANG': 'en_US.UTF-8', 17:50:06 INFO - 'LANGUAGE': 'en_US:en', 17:50:06 INFO - 'LOGNAME': 'cltbld', 17:50:06 INFO - 'MAIL': '/var/mail/cltbld', 17:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:06 INFO - 'MOZ_NO_REMOTE': '1', 17:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:06 INFO - 'NO_EM_RESTART': '1', 17:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:06 INFO - 'PWD': '/builds/slave/test', 17:50:06 INFO - 'SHELL': '/bin/bash', 17:50:06 INFO - 'SHLVL': '1', 17:50:06 INFO - 'TERM': 'linux', 17:50:06 INFO - 'TMOUT': '86400', 17:50:06 INFO - 'USER': 'cltbld', 17:50:06 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 17:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:06 INFO - '_': '/tools/buildbot/bin/python'} 17:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:06 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:50:06 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:50:06 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:50:06 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:50:06 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:50:06 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:50:06 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:50:06 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:50:06 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:50:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:50:06 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:50:06 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:50:06 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:50:06 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:50:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:50:07 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:50:07 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:50:07 INFO - Installing collected packages: simplejson 17:50:07 INFO - Running setup.py install for simplejson 17:50:08 INFO - building 'simplejson._speedups' extension 17:50:08 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:50:08 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:50:08 INFO - Successfully installed simplejson 17:50:08 INFO - Cleaning up... 17:50:09 INFO - Return code: 0 17:50:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:50:09 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:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:09 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:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:09 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 0x184a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a12b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb79c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb4d60>, '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 0x1bb5a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5ef0>, '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': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', '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:50:09 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:50:09 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:50:09 INFO - Using env: {'DISPLAY': ':0', 17:50:09 INFO - 'HOME': '/home/cltbld', 17:50:09 INFO - 'LANG': 'en_US.UTF-8', 17:50:09 INFO - 'LANGUAGE': 'en_US:en', 17:50:09 INFO - 'LOGNAME': 'cltbld', 17:50:09 INFO - 'MAIL': '/var/mail/cltbld', 17:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:09 INFO - 'MOZ_NO_REMOTE': '1', 17:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:09 INFO - 'NO_EM_RESTART': '1', 17:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:09 INFO - 'PWD': '/builds/slave/test', 17:50:09 INFO - 'SHELL': '/bin/bash', 17:50:09 INFO - 'SHLVL': '1', 17:50:09 INFO - 'TERM': 'linux', 17:50:09 INFO - 'TMOUT': '86400', 17:50:09 INFO - 'USER': 'cltbld', 17:50:09 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 17:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:09 INFO - '_': '/tools/buildbot/bin/python'} 17:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:50:09 INFO - Cleaning up... 17:50:09 INFO - Return code: 0 17:50:09 INFO - Running post-action listener: _resource_record_post_action 17:50:09 INFO - Running post-action listener: _start_resource_monitoring 17:50:09 INFO - Starting resource monitoring. 17:50:09 INFO - [mozharness: 2017-10-03 00:50:09.262204Z] Finished create-virtualenv step (success) 17:50:09 INFO - [mozharness: 2017-10-03 00:50:09.262713Z] Running install step. 17:50:09 INFO - Running pre-action listener: _resource_record_pre_action 17:50:09 INFO - Running main action method: install 17:50:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:09 INFO - Reading from file tmpfile_stdout 17:50:09 INFO - Detecting whether we're running mozinstall >=1.0... 17:50:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:50:09 INFO - Reading from file tmpfile_stdout 17:50:09 INFO - Output received: 17:50:09 INFO - Usage: mozinstall [options] installer 17:50:09 INFO - Options: 17:50:09 INFO - -h, --help show this help message and exit 17:50:09 INFO - -d DEST, --destination=DEST 17:50:09 INFO - Directory to install application into. [default: 17:50:09 INFO - "/builds/slave/test"] 17:50:09 INFO - --app=APP Application being installed. [default: firefox] 17:50:09 INFO - mkdir: /builds/slave/test/build/application 17:50:09 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:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:50:27 INFO - Reading from file tmpfile_stdout 17:50:27 INFO - Output received: 17:50:27 INFO - /builds/slave/test/build/application/firefox/firefox 17:50:27 INFO - Running post-action listener: _resource_record_post_action 17:50:27 INFO - [mozharness: 2017-10-03 00:50:27.248591Z] Finished install step (success) 17:50:27 INFO - [mozharness: 2017-10-03 00:50:27.248844Z] Running setup-mitmproxy step. 17:50:27 INFO - Running pre-action listener: _resource_record_pre_action 17:50:27 INFO - Running main action method: setup_mitmproxy 17:50:27 INFO - Skipping: mitmproxy is not required 17:50:27 INFO - Running post-action listener: _resource_record_post_action 17:50:27 INFO - [mozharness: 2017-10-03 00:50:27.250005Z] Finished setup-mitmproxy step (success) 17:50:27 INFO - [mozharness: 2017-10-03 00:50:27.250246Z] Running run-tests step. 17:50:27 INFO - Running pre-action listener: _resource_record_pre_action 17:50:27 INFO - Running pre-action listener: _set_gcov_prefix 17:50:27 INFO - Running main action method: run_tests 17:50:27 WARNING - Try message not found. 17:50:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:50:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:50:27 INFO - Python 2.7.3 17:50:27 INFO - Return code: 0 17:50:27 INFO - grabbing minidump binary from tooltool 17:50:27 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:50:27 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 0x1bb4d60>, '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 0x1bb5a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb5ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:50:27 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:50:27 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:50:27 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:50:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:50:27 INFO - Return code: 0 17:50:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:50:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:50:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:50:27 INFO - ENV: RUST_BACKTRACE is now full 17:50:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:50:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:50:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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:50:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --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:50:27 INFO - Using env: {'DISPLAY': ':0', 17:50:27 INFO - 'HOME': '/home/cltbld', 17:50:27 INFO - 'LANG': 'en_US.UTF-8', 17:50:27 INFO - 'LANGUAGE': 'en_US:en', 17:50:27 INFO - 'LOGNAME': 'cltbld', 17:50:27 INFO - 'MAIL': '/var/mail/cltbld', 17:50:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:50:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:27 INFO - 'MOZ_NO_REMOTE': '1', 17:50:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:27 INFO - 'NO_EM_RESTART': '1', 17:50:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:27 INFO - 'PWD': '/builds/slave/test', 17:50:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:50:27 INFO - 'RUST_BACKTRACE': 'full', 17:50:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:50:27 INFO - 'SHELL': '/bin/bash', 17:50:27 INFO - 'SHLVL': '1', 17:50:27 INFO - 'TERM': 'linux', 17:50:27 INFO - 'TMOUT': '86400', 17:50:27 INFO - 'USER': 'cltbld', 17:50:27 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 17:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:27 INFO - '_': '/tools/buildbot/bin/python'} 17:50:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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:50:27 INFO - mozversion application_buildid: 20171002232253 17:50:27 INFO - mozversion application_changeset: 65dac33a5682f3ec5a675e7f3314b0c1520a13fa 17:50:27 INFO - mozversion application_display_name: Nightly 17:50:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:50:27 INFO - mozversion application_name: Firefox 17:50:27 INFO - mozversion application_remotingname: firefox 17:50:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:50:27 INFO - mozversion application_vendor: Mozilla 17:50:27 INFO - mozversion application_version: 58.0a1 17:50:27 INFO - mozversion platform_buildid: 20171002232253 17:50:27 INFO - mozversion platform_changeset: 65dac33a5682f3ec5a675e7f3314b0c1520a13fa 17:50:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:50:27 INFO - mozversion platform_version: 58.0a1 17:50:27 INFO - using testdate: 1506991827 17:50:27 INFO - actual date: 1506991827 17:50:27 INFO - starting webserver on 'localhost:35504' 17:50:27 INFO - SUITE-START | Running 2 tests 17:50:27 INFO - TEST-START | dromaeo_css 17:50:27 INFO - Initialising browser for dromaeo_css test... 17:50:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35504/getInfo.html -profile /tmp/tmpGgsb66/profile 17:50:27 INFO - TEST-INFO | started process 17403 (/builds/slave/test/build/application/firefox/firefox http://localhost:35504/getInfo.html) 17:50:33 INFO - TEST-INFO | 17403: exit 0 17:50:33 INFO - Browser initialized. 17:50:33 INFO - Running cycle 1/1 for dromaeo_css test... 17:50:33 INFO - Using env: {'DISPLAY': ':0', 17:50:33 INFO - 'HOME': '/home/cltbld', 17:50:33 INFO - 'JSGC_DISABLE_POISONING': '1', 17:50:33 INFO - 'LANG': 'en_US.UTF-8', 17:50:33 INFO - 'LANGUAGE': 'en_US:en', 17:50:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:50:33 INFO - 'LOGNAME': 'cltbld', 17:50:33 INFO - 'MAIL': '/var/mail/cltbld', 17:50:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:50:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:50:33 INFO - 'MOZ_CRASHREPORTER': '1', 17:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:50:33 INFO - 'MOZ_NO_REMOTE': '1', 17:50:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:33 INFO - 'NO_EM_RESTART': '1', 17:50:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:33 INFO - 'PWD': '/builds/slave/test', 17:50:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:50:33 INFO - 'RUST_BACKTRACE': 'full', 17:50:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:50:33 INFO - 'SHELL': '/bin/bash', 17:50:33 INFO - 'SHLVL': '1', 17:50:33 INFO - 'STYLO_FORCE_DISABLED': '1', 17:50:33 INFO - 'TERM': 'linux', 17:50:33 INFO - 'TMOUT': '86400', 17:50:33 INFO - 'USER': 'cltbld', 17:50:33 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 17:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:33 INFO - '_': '/tools/buildbot/bin/python'} 17:50:33 INFO - TEST-INFO | started process 17676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGgsb66/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:50:34 INFO - PID 17676 | 17:50:34 INFO - PID 17676 | (/builds/slave/test/build/application/firefox/firefox:17726): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:50:34 INFO - PID 17676 | 17:50:44 INFO - PID 17676 | RSS: Main: 142319616 17:50:44 INFO - PID 17676 | 17:53:42 INFO - PID 17676 | Cycle 1(1): loaded http://localhost:35504/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35504/tests/dromaeo/cssquery-ext.html) 17:53:43 INFO - PID 17676 | RSS: Main: 143425536 17:53:43 INFO - PID 17676 | 17:56:44 INFO - PID 17676 | Cycle 1(1): loaded http://localhost:35504/tests/dromaeo/cssquery-ext.html (next: http://localhost:35504/tests/dromaeo/cssquery-jquery.html) 17:56:45 INFO - PID 17676 | RSS: Main: 144683008 17:56:45 INFO - PID 17676 | 17:59:47 INFO - PID 17676 | Cycle 1(1): loaded http://localhost:35504/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35504/tests/dromaeo/cssquery-mootools.html) 17:59:47 INFO - PID 17676 | RSS: Main: 145666048 17:59:47 INFO - PID 17676 | 18:02:49 INFO - PID 17676 | Cycle 1(1): loaded http://localhost:35504/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35504/tests/dromaeo/cssquery-prototype.html) 18:02:49 INFO - PID 17676 | RSS: Main: 145420288 18:02:49 INFO - PID 17676 | 18:05:52 INFO - PID 17676 | Cycle 1(1): loaded http://localhost:35504/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35504/tests/dromaeo/cssquery-yui.html) 18:05:53 INFO - PID 17676 | RSS: Main: 148205568 18:05:53 INFO - PID 17676 | 18:08:54 INFO - PID 17676 | Cycle 1(1): loaded http://localhost:35504/tests/dromaeo/cssquery-yui.html (next: http://localhost:35504/tests/dromaeo/cssquery-dojo.html) 18:08:54 INFO - PID 17676 | RSS: Main: 149405696 18:08:54 INFO - PID 17676 | 18:08:54 INFO - PID 17676 | __start_tp_report 18:08:54 INFO - PID 17676 | _x_x_mozilla_page_load 18:08:54 INFO - PID 17676 | _x_x_mozilla_page_load_details 18:08:54 INFO - PID 17676 | |i|pagename|runs| 18:08:54 INFO - PID 17676 | |0;dojo.html;3916.314644937135;3920.05918579541;3923.333033384324;3944.3689009758446;3948.210357928414;6264.997600383939;6282.340354262799;6331.430171284584;6355.428011478966;6413.7755178568705;6313.242410910697;6333.778317758879;6336.5247606429475;6341.5877967932165;6352.6188428694195;5608.635438696492;5654.180143879135;5674.517665998395;5745.052066409037;5835.679037652927;5776.624519406246;5782.566307526931;5789.102689083199;5789.623674461168;5842.824715258549;5625.268715067056;5798.7100644967795;5855.033919403293;5875.941240587604;5882.970585147068;5686.630369026;5719.113537401709;5751.884962300731;5802.390748971382;5807.2160258365;5705;5712.542996560265;5772.076467765138;5787.536997040227;5801.767929282823;6268.373162683741;6307.810765677037;6350.904736428957;6383.71273292703;6420.839479013015;6843.144606924135;6850.588964662136;6879.690413931385;6885.690143943484;6912.585244885273;6862.210845752752;6957.79126626202;6959.61722105284;6965.303469653045;6969.860602787967;6349.650769207692;6353.30113687494;6370;6452.677366131675;6455.451286640641;6897.758578449831;6973.407260382823;6989.231184569693;7104.360607545345;7111.217766045731;6757.459403247728;6780.898286525706;6787.830304242433;6858.074159988338;6863.553868998499;6859.794206173823;6898;6934.202566704894;6956.373926346552;6970.825729356807;6798.116244888133;6803.693833777492;6862.9313706862295;6865.347791959855;6909.170899492093;6737.427318677967;6819.147606549182;6824.146981627297;6828.5902845829405;6835.829104272333;4934.407871055496;4940.876478088005;4983.25251212321;4995.075910956412;5021.322121513549;4528.207563676344;4533.38799262102;4565.497795242521;4566.88582785433;4644.210484217691;6357.04644303349;6394.328595497499;6405.231372235362;6408.967955160194;6410.775622853178;6851.246362900077;6855.897161542581;6941.861162776716;6944.826379340456;6949.687264073129;6316.494680425555;6328.525360597881;6397.264314603787;6403.359664033559;6404.103425520431;5454.481824226692;5513.365962914236;5513.862153446196;5571.275734154534;5579.4420557944695;7148.428125749928;7150.070490836158;7205.71177152908;7233.963830180815;7237.746678866214;6873.347032031949;6891.483138764513;6967.79096627102;6968.721251149897;6969.2682268361095;6975.651217439006;7040.542364746275;7062.540934839219;7065.364117229474;7120.572765634079;6749.763758268437;6767.221769496571;6787.083743694538;6824.215215250111;6830.829229269308;6854.280300568368;6866.519343645897;6875.690593923386;6895.931040689529;6962.651867406508;6634.170728658918;6635.668216589248;6696.564723293165;6705.228898676714;6724.630145342053;6537.836554086186;6595.4393876521035;6634;6694.263631000488;6733.93266067333;6478.1578394808375;6489.837754056186;6582.210134783665;6584.637844918576;6594.70323835419;6749.156355455568;6779.559328643622;6797.0823938767635;6813.182418109858;6818.454523638196;6490.902636460552;6514.511411644051;6543.411093001652;6608.140941677551;6634.701438435379 18:08:54 INFO - PID 17676 | |1;ext.html;938.7934654376039;958.2669258017618;972.922166226702;1024.810410074136;1027.8406846938722;44305.77847110764;45224;45307.54692453075;45385.546144538544;45512.317315240216;43311.35032974508;45601;46510.30234546476;46610.53389466104;46808.76595617025;8360.91639083609;8752.606132724042;8772;8793.428427152247;8800.383973121883;8551.401401901869;8619.698310559132;8666.263367613728;8666.56667166639;8679.869801952977;8644.481331120121;8659.393842431033;8675.436096653697;8713.128687131299;8721.738347849543;8633.784155396103;8642.438241514314;8656.307495400384;8667;8701.43440676354;8552;8592.613332400057;8604.225619694194;8614.310855131574;8616.526091064989;41749.165016699495;41935;42042;42236.57763422357;42275.57724422778;3795.9240815183816;3815.3323168445413;3843.385058390672;3848.9415410761985;3855.6529912307747;35184.64815351839;35240.29519409623;35255.11862203466;35284.64715352839;35323.4701479478;5352.759125839347;5369.0604144274985;5413.188021796723;5435.374931882805;5590.077637189859;228919;232022;235564;238058;238227;53316;53342;53469.732651337275;53471.73264133732;53533.73233133809;56797;57029.71485142548;57041.14438283429;57158.42841571531;57197.42802571921;17120.315187392363;17248.827511724972;17262.568435788955;17273;17488.825111748974;14084.084534505224;14088.506902258372;14088.506902258578;14091.577252682437;14095.154290742588;14578.927105364406;14630.634234144232;14651.633709157357;14708.852911470749;14766.187859667607;5373.596980226499;5438.91841622376;5459.344878614592;5577.832665020056;5627.5779316551425;1087.1683162380784;1088.5591335509132;1103.4372470040337;1107.058999850121;1111.2721167635211;24599.262022139363;24605.261842144766;24667.506649866904;24681.259562213163;24861.378465538506;1211.5093387178206;1217.963461096151;1220.530095913062;1233.210745123122;1236.5424792826711;13032.218066916015;13130.080894337305;13182.274974876282;13229.140105893086;13248.27134507592;295897;296073;297045;297428;297881;59467;60097.399026010055;60119;60169.097463538084;60206.397936020076;1531.954041378738;1537.1084770833113;1548.0866288889608;1567.0597641415059;1576.7004269188817;24464.510709785347;24559.386015349046;24625.261242162764;24755.504889902462;24812.131575394775;41642.58357416387;41832.16335673209;41953.37069943892;41977.790111049246;42058.36912446377;249678;250755;251393;251456;251969;37605;37983.43024854684;38170.23659526849;38465.2306953865;38676;48302.75848620734;48318.758406207744;48745.268820967;48920.5107948916;49077.50922490729;35773.284534309685;35975;36115.819420903776;36264;36598;35969.82015090012;36181.457278140326;36568.817155914054;36603.816980914926;36630;39126.6087339123;40593.391099134125;40604.79697601493;40785.1842963145;40917.795411023944;35066.298674025864;35338.64661353456;35396.646033539335;35592.64407355997;35654.28691426105;24750.38124046913;24873.62689559622;25065.248042558753;25338.36654083589;25568.360790980376 18:08:54 INFO - PID 17676 | |2;jquery.html;629.2291942370597;631.6210273835698;638.1066506890353;640.1837656987337;643.8486955565443;23366.88316558419;23397.766022339772;24629.876850615743;24730.134445294396;24898.875505622447;25164.49671006579;26627.201183964513;26639;26646.200613981564;26661.466770664625;6581.341865813416;6600.702968366411;6717.059611654372;6726.058351830748;6726.529142959995;6523.6738163091895;6594.93405065948;6880.690368933385;6888.070110535064;6949.652517374137;6904.102466679325;6906;6908.101946746916;6909.792706218822;6919.377256046955;6677.131972843548;6872.244053154149;6915.997180408837;6916.515843890929;6939.965300173517;6479.481641468718;6487.481001519867;6490.707918143695;6495.220573531159;6496.8700625987685;30366.240843978856;31013;31017.534736978963;31036.224094397596;31087.067387978397;2169.1540299283292;2248.6964259824877;2253.2001139595372;2254.1208928517726;2255.210676263311;19877.403677889688;21058.789412105834;21154.682679759815;21270.680939785914;21275;2524.1670248817845;2578.613208018812;2590.1452520668136;2679.933001674954;2684.7583717465327;131014.3449282757;137371;154657;163037.18481407635;163306.18346908188;16359.42742004048;16643.167841607872;16761.245743941552;16863.662726745642;16992.660146796996;26322.736772632412;26435.603465948025;26447.206583802516;26491.602625960626;26530;10338.844917326247;10441.947790261152;10547.630832920811;10591.417472038958;10631.84052239217;9355.345125841262;9390.5304734763;9484.715458536255;9530.380525265835;9602.567884445216;9716.659916902874;9796.608135674636;9923.1069203772;10163.542640581192;10295.227857910686;2957.8668959896854;2961.188069387246;2995.4458425190974;3086.2592977685645;3124.5469406935867;1031.2059714020313;1031.886492485826;1045.5347370420243;1052.273930987616;1061.3048453263125;20149.597008059758;20495.385138445872;20601.48496287605;20871.269505567536;21033.15867365319;1081.853949716794;1102.7518808268076;1108.3516143056402;1109.944502774858;1117.1565468071553;11277.54889804415;11355.375454349925;11360.318380897173;11375.829362559569;11472.77054458906;586149;587283;599961;602910;629481;126365;128685;129646;130442;131097;1184.59131599598;1219.3415555600054;1220.462996281651;1228.748106638137;1228.9078319126102;18278.268869245083;18432;18493.81506184921;18856.622867542847;18906.905465472584;64350.67824661034;64629;64863.67568162129;65116.67441662761;65961;84827.5758621203;84904.57547712221;85311;86135.569322153;86374;15801.288941997867;16082.195890205678;16242.106684132486;16256.67486650284;16302.103384313503;23758.88120559386;23893.880530597235;23995.52008959846;24121.276361709177;24198.032078716653;18756.155972980974;18813.623727525646;19000.809991900456;19190;19195.80804191996;17688.729803430575;17730.645387092445;17788;17894.373696920546;18027.369042083465;19280.4215873524;19565;19831.30590429328;19863.106160222535;19920.60158796787;15701;15759.133247671489;15859.682806344039;15865.52403427899;15867.603309917344;17966.191521381308;19081.236750529824;19083.90458047701;19115;19195.232190712217 18:08:54 INFO - PID 17676 | |3;mootools.html;1458.9708205835884;1484.8218213814337;1485.7845612386204;1490.5751860719697;1493.111598598834;16707.415240466587;17371.56571085722;17398.043107629106;17400.47798566042;17405.390811321606;16973.3210671573;17028;17091.05999170045;17105.31578736849;17106.059166745825;2839.119872839416;2865.899693510733;2912.519434293339;2920.2553348896004;2931.106012666136;2856.742893139617;2862.298736809474;2863.871125799344;2879.5680647902773;2882.192985963923;2754.6832114306812;2964.7035296470394;2968.5250359942415;2971.4205729882574;2990.8953186638473;2926.765858731307;2929.9414011719646;2931.4430258250973;2937.1922721251613;2962.200205944394;2809.9884041744954;2846.7153284671576;2875.43928933858;2931.868065937038;2938.9706102938912;16627.41804036865;16765.413210537696;16765.580860478465;16777.32890684371;16781.580460488465;8532.78668033298;8763.868541971875;8790.692325768632;8800.735977920673;8806.163414475615;5586;5739.971300143473;5771.480566748971;5795.478406943354;5899.73451194693;2124.5007423255524;2155.687425323335;2161.3939510577493;2170.815480684144;2207.404000919759;30050.54924176139;30340.24149396283;30425.087247382613;30449.695503044906;30521.08436746901;8117.391195660349;8210.096889342167;8371.874421883676;8442.493450392873;8510.872336914952;20228.595428091357;20307.492312692004;20317.49206269855;20384;20509.17963281452;8661.826763464695;8818;8822.25010874083;8832.116788321246;8861.955690221508;7847.607619618996;7912.643931023118;7915.643796029078;7923.484973476706;8073.6770529178175;5917;5944.554158438134;5994.1608174855555;6006.699665016732;6063.787767428119;1719.7162468192607;1740.6518696260798;1742.8867123637176;1761.2866788950496;1798.5233913013062;937.7186843946789;937.723371605378;943.6366998705548;948.9288303377136;961.8605302231138;8123.918760812435;8134.715284964997;8151;8154.8776768348525;8195.180481951877;803.333233416263;808.2402541610867;809.8177909970327;824.3652387661467;825.1500954017372;5105.9489405106215;5302.68183908959;5862.677552734641;5902.498287645598;6070.362611925772;24681.506369872863;24765.752342476346;25507.36231594188;25520.872395638275;25822.74177258241;24393;24565.38586535351;25100.623490647657;25243.11649092273;25323.240302790946;12491.188072775241;12497.250164989948;12613.873861261454;12653.430595623218;12703.42834572428;9271.67549135777;9325.114114159143;9382.765430864283;9451.574679139592;9475.47884866339;20897.223735982003;21090.261840835497;21283.574328513652;21463.678044829026;21787.45531361665;21632.567348652625;21642.783572164077;21737.565248695253;21840.563188736454;21971.670424943957;12654.430550625428;12727.618171454871;12852.293123877902;12883.677908052374;13040.347982601023;15238.314275857834;15385.769213461583;15389.84610153929;15397.538073857802;15422;11990.460429280529;12298.938505307417;12394.194377365442;12421.441035153259;12516.12387132892;12217.93891030539;12398.13213075076;12522.686932826387;12614.873851261736;12664;10816.67549973502;11028.669139925814;11035.944820276169;11037.83443248368;11038.668839934815;8049.597520123853;8184.386171037315;8219.260266576037;8285.171482851667;8308.086110527716;8154.551499667576;8183.79540511492;8263.545504997282;8313.542755148525;8341.124181960808 18:08:54 INFO - PID 17676 | |4;prototype.html;558.6815515156362;576.8154190658989;585.628126139901;589.0751520113422;601.3505414152716;6220.50235981121;6238.469730072944;6329.810105696825;6341.460975817055;6346.587471814329;6250.687465626723;6260.123582698426;6266.279377871546;6273.309935907058;6307.558470907038;5140.588752899768;5142.948570514303;5177.145770947789;5187.04039752647;5193.584513238932;4976.402831660206;5035.697858128506;5143.151380022292;5154.098032844256;5169.56058735008;4996.150654388744;5017.247412888059;5042.495750424947;5072.3405957225505;5105.923411148836;5009.2486127080865;5070.797168113271;5072.391313042459;5078.64449488536;5100.33695619569;4474.194644963905;4568.177728008957;4568.862934111982;4594.379758732562;4611.838585649486;6077.392260773887;6097;6153.138560601519;6163.291221509494;6168.383161683841;5972.880542389128;5994.220751302303;6016.465801220661;6022.608530445507;6038.124471951543;6690.264070952191;6750.097458093018;6761.492888033417;6768.458523318122;6790.932090679079;5014.097462456756;5182.922256166161;5228.581713462914;5229.947700522984;5244.711540865251;6732.158480189976;6810.182778066664;6899.7235511430545;6949.810809595012;6969.247147376758;5314.458806945942;5342.904704535561;5343.919841202385;5352.357717073976;5359.249705041298;5363.846772943836;5373.543248823816;5447.12845944647;5448.91826622601;5458.4814442627885;5987.64074155552;5991.670458124845;5999.5800293979;6000.549958753024;6006.369331220247;6708.932910670831;6738.764143254963;6744.6627668616375;6756.189257289157;6781.525293229525;1839.8252166044472;1846.3999200259968;1875.7655293088364;1883.5667796406904;1890.9149088290785;1300.8829205371562;1301.9088663793443;1332.9200247985152;1337.411538922871;1340.8323959505062;6072.4398124335485;6130.754769809158;6192.721327540272;6216.564840461125;6218.284897236876;6650.6698660267175;6724.125863637793;6741.224759152662;6830.59016459014;6843.589384636938;6139.907901381483;6183.628982260989;6194.628322300677;6229;6278.121063051085;3547.2373439710586;3560.8041557714573;3563.2540055373197;3582.9104272393397;3608.4767708682093;7036.472264580177;7066.7173313066905;7069.681864316118;7072.964635176894;7147.785566433015;6908.240093589701;7024.262452442522;7043.401310888632;7050.5769653820935;7135.394536229307;6845.589264644137;6858.897116543156;6881.277465866112;6951.350540965932;7019.858943022427;6702.36327548882;6725.697343619451;6777.661116944035;6805.455563554805;6810.523263371517;6486.578372405778;6528.836779080561;6555.508336874658;6616.8345791355605;6664.933350666432;6910.239873613999;6934.930650693428;6955.947995341286;6984.311040249642;7038.859222815618;5272.314599102092;5299.947000529945;5307.6284660073425;5308.946910530845;5336.839894803162;6533.542652014314;6546.24718157418;6694.054615968958;6813.386795188457;6903.827404314932;6503.317151699003;6523.18460192476;6534.759304863748;6608.966955165193;6620.205575330799;6367.860890421263;6466.902996454963;6530.8367290818105;6532.346765323429;6613.280547057703;6286.77407905454;6343.429091381798;6447.3552644735155;6452.709628066842;6452.870942581216;6501.869962600627;6523.804285871432;6633.402993730394;6642.966785166043;6686.264510903894;6412.35876412355;6434.678266086583;6463.418292353711;6480.157579514633;6544.3782840630065 18:08:54 INFO - PID 17676 | |5;yui.html;923.3674932671125;973.260322155162;984.3011461862078;995.9153471954884;998.8152191844509;20355.796442035593;21034.894825525887;21049.263275785368;21072.683909741365;21121.57756844866;19686;19966.101525431353;20509;20626.89686551569;20854.687179692315;1021.0300214795936;1035.5754140802273;1036.3367444835312;1036.533559898045;1036.9377837329746;1016.9389836609827;1037.901399367059;1043.1706793099504;1045.4720366215051;1048.6120135549857;1114.0419239454063;1120.7814476177148;1122.764219513903;1123.4831977290455;1124.2018167101369;1108.3405373802534;1116.2911551164987;1117.4412793603199;1118.2954738514684;1118.7538741476903;765.6324964017247;786.3276898251969;793.7380664380798;794.1780257433586;822.461287856455;21535.569288614297;21757.564848703096;21779.67330490044;21805.67291490629;21827.126914923385;22858.428539286484;23445.648315275284;23473.7652623475;23670.17154399605;23688.40778980522;19167.61664766711;19273.518162045923;19274.903625481784;19391.90304048485;19414.611707765907;4095.692823038254;4117.5882411758585;4119.752814831089;4125.1131006833375;4125.463689720347;171588.99999999875;172683;173668;173946;174162;16920.238589263514;17214.708896832537;17298.394556190724;17418.303267869396;17429.302827886742;33016.66983330184;33659.495107573406;33691.49462758061;34094.82952585221;34159.65840341614;9473.621055157717;9880.35777674449;9917.30578859473;9979.251556133318;9990.650327238513;4741.857744267678;4859.246816743411;4979.950200498021;4981.775820088104;4983.875403114951;6084.787032453843;6194.783182588588;6198.163247961467;6199.194104766351;6213.844653883599;1123.9606613768478;1141.7887690777234;1162.5001249462812;1170.414792603698;1174.2308787744041;744.6872313628289;756.3004221095465;766.4558163703832;779.653054390802;779.8011507065776;13421.396037178156;13822.585322440344;14140.717185656229;15076.773848392282;15121.319540620478;725.6480606905646;730.3426915775844;736.9631518424058;744.6016381236012;751.5866273549526;6193.783217587453;6301.873962520724;6339.302676705559;6368.872622547523;6379.043143528508;155015;158823;161503;161961.19019404828;167742;115554;115627.42186289014;130533;136235;140937;120825;121022;121456.39271803584;122329;122875.99999999821;13707.794383084061;14563.344649490586;14612.19632920157;14637.341319640855;14822.184779836782;56659.43340566542;56977.71511142418;57818.7109064452;57870.4212957865;58215.417845822696;97238;97652;97943;101528.49235753773;101873.49063254637;20760.68858967147;21298.78701212968;21302;21475.248366307103;21577.892110539346;23772.167974120825;23852.284431467084;23873.52252954966;23962;24608.138715144883;20117.497062572966;20182.69725954141;20437.284695035603;20564.485887852923;21794.128234870426;21116.47208819792;21248;21450.570988579828;21470.14119435205;21604.67592986075;20942.267020654202;21463.678044829652;21792.45518862041;21891;22074.779252207274;15174.31715572824;15408.537743867702;15664;16077.8151889263;16519.256633451285;15411.69176616439;15790.526284211492;15863.127527986071;15913.124778137313;16000.8399916004 18:08:54 INFO - PID 17676 | __end_tp_report 18:08:54 INFO - PID 17676 | __start_cc_report 18:08:54 INFO - PID 17676 | _x_x_mozilla_cycle_collect,284 18:08:54 INFO - PID 17676 | __end_cc_report 18:08:54 INFO - PID 17676 | __startTimestamp1506992934949__endTimestamp 18:08:54 INFO - PID 17676 | 18:08:54 INFO - PID 17676 | ------- Summary: start ------- 18:08:54 INFO - PID 17676 | Number of tests: 6 18:08:54 INFO - PID 17676 | 18:08:54 INFO - PID 17676 | [#0] dojo.html Cycles:165 Average:6339.38 Median:6584.64 stddev:746.71 (11.3%) stddev-sans-first:724.40 18:08:54 INFO - PID 17676 | Values: 3916.3 3920.1 3923.3 3944.4 3948.2 6265.0 6282.3 6331.4 6355.4 6413.8 6313.2 6333.8 6336.5 6341.6 6352.6 5608.6 5654.2 5674.5 5745.1 5835.7 5776.6 5782.6 5789.1 5789.6 5842.8 5625.3 5798.7 5855.0 5875.9 5883.0 5686.6 5719.1 5751.9 5802.4 5807.2 5705.0 5712.5 5772.1 5787.5 5801.8 6268.4 6307.8 6350.9 6383.7 6420.8 6843.1 6850.6 6879.7 6885.7 6912.6 6862.2 6957.8 6959.6 6965.3 6969.9 6349.7 6353.3 6370.0 6452.7 6455.5 6897.8 6973.4 6989.2 7104.4 7111.2 6757.5 6780.9 6787.8 6858.1 6863.6 6859.8 6898.0 6934.2 6956.4 6970.8 6798.1 6803.7 6862.9 6865.3 6909.2 6737.4 6819.1 6824.1 6828.6 6835.8 4934.4 4940.9 4983.3 4995.1 5021.3 4528.2 4533.4 4565.5 4566.9 4644.2 6357.0 6394.3 6405.2 6409.0 6410.8 6851.2 6855.9 6941.9 6944.8 6949.7 6316.5 6328.5 6397.3 6403.4 6404.1 5454.5 5513.4 5513.9 5571.3 5579.4 7148.4 7150.1 7205.7 7234.0 7237.7 6873.3 6891.5 6967.8 6968.7 6969.3 6975.7 7040.5 7062.5 7065.4 7120.6 6749.8 6767.2 6787.1 6824.2 6830.8 6854.3 6866.5 6875.7 6895.9 6962.7 6634.2 6635.7 6696.6 6705.2 6724.6 6537.8 6595.4 6634.0 6694.3 6733.9 6478.2 6489.8 6582.2 6584.6 6594.7 6749.2 6779.6 6797.1 6813.2 6818.5 6490.9 6514.5 6543.4 6608.1 6634.7 18:08:54 INFO - PID 17676 | 18:08:54 INFO - PID 17676 | [#1] ext.html Cycles:180 Average:44300.29 Median:20992.78 stddev:68233.92 (325.0%) stddev-sans-first:68347.66 18:08:54 INFO - PID 17676 | Values: 938.8 958.3 972.9 1024.8 1027.8 44305.8 45224.0 45307.5 45385.5 45512.3 43311.4 45601.0 46510.3 46610.5 46808.8 8360.9 8752.6 8772.0 8793.4 8800.4 8551.4 8619.7 8666.3 8666.6 8679.9 8644.5 8659.4 8675.4 8713.1 8721.7 8633.8 8642.4 8656.3 8667.0 8701.4 8552.0 8592.6 8604.2 8614.3 8616.5 41749.2 41935.0 42042.0 42236.6 42275.6 3795.9 3815.3 3843.4 3848.9 3855.7 35184.6 35240.3 35255.1 35284.6 35323.5 5352.8 5369.1 5413.2 5435.4 5590.1 228919.0 232022.0 235564.0 238058.0 238227.0 53316.0 53342.0 53469.7 53471.7 53533.7 56797.0 57029.7 57041.1 57158.4 57197.4 17120.3 17248.8 17262.6 17273.0 17488.8 14084.1 14088.5 14088.5 14091.6 14095.2 14578.9 14630.6 14651.6 14708.9 14766.2 5373.6 5438.9 5459.3 5577.8 5627.6 1087.2 1088.6 1103.4 1107.1 1111.3 24599.3 24605.3 24667.5 24681.3 24861.4 1211.5 1218.0 1220.5 1233.2 1236.5 13032.2 13130.1 13182.3 13229.1 13248.3 295897.0 296073.0 297045.0 297428.0 297881.0 59467.0 60097.4 60119.0 60169.1 60206.4 1532.0 1537.1 1548.1 1567.1 1576.7 24464.5 24559.4 24625.3 24755.5 24812.1 41642.6 41832.2 41953.4 41977.8 42058.4 249678.0 250755.0 251393.0 251456.0 251969.0 37605.0 37983.4 38170.2 38465.2 38676.0 48302.8 48318.8 48745.3 48920.5 49077.5 35773.3 35975.0 36115.8 36264.0 36598.0 35969.8 36181.5 36568.8 36603.8 36630.0 39126.6 40593.4 40604.8 40785.2 40917.8 35066.3 35338.6 35396.6 35592.6 35654.3 24750.4 24873.6 25065.2 25338.4 25568.4 18:08:54 INFO - PID 17676 | 18:08:54 INFO - PID 17676 | [#2] jquery.html Cycles:180 Average:39827.70 Median:2254.67 stddev:100699.99 (4466.3%) stddev-sans-first:100939.47 18:08:54 INFO - PID 17676 | Values: 629.2 631.6 638.1 640.2 643.8 23366.9 23397.8 24629.9 24730.1 24898.9 25164.5 26627.2 26639.0 26646.2 26661.5 6581.3 6600.7 6717.1 6726.1 6726.5 6523.7 6594.9 6880.7 6888.1 6949.7 6904.1 6906.0 6908.1 6909.8 6919.4 6677.1 6872.2 6916.0 6916.5 6940.0 6479.5 6487.5 6490.7 6495.2 6496.9 30366.2 31013.0 31017.5 31036.2 31087.1 2169.2 2248.7 2253.2 2254.1 2255.2 19877.4 21058.8 21154.7 21270.7 21275.0 2524.2 2578.6 2590.1 2679.9 2684.8 131014.3 137371.0 154657.0 163037.2 163306.2 16359.4 16643.2 16761.2 16863.7 16992.7 26322.7 26435.6 26447.2 26491.6 26530.0 10338.8 10441.9 10547.6 10591.4 10631.8 9355.3 9390.5 9484.7 9530.4 9602.6 9716.7 9796.6 9923.1 10163.5 10295.2 2957.9 2961.2 2995.4 3086.3 3124.5 1031.2 1031.9 1045.5 1052.3 1061.3 20149.6 20495.4 20601.5 20871.3 21033.2 1081.9 1102.8 1108.4 1109.9 1117.2 11277.5 11355.4 11360.3 11375.8 11472.8 586149.0 587283.0 599961.0 602910.0 629481.0 126365.0 128685.0 129646.0 130442.0 131097.0 1184.6 1219.3 1220.5 1228.7 1228.9 18278.3 18432.0 18493.8 18856.6 18906.9 64350.7 64629.0 64863.7 65116.7 65961.0 84827.6 84904.6 85311.0 86135.6 86374.0 15801.3 16082.2 16242.1 16256.7 16302.1 23758.9 23893.9 23995.5 24121.3 24198.0 18756.2 18813.6 19000.8 19190.0 19195.8 17688.7 17730.6 17788.0 17894.4 18027.4 19280.4 19565.0 19831.3 19863.1 19920.6 15701.0 15759.1 15859.7 15865.5 15867.6 17966.2 19081.2 19083.9 19115.0 19195.2 18:08:54 INFO - PID 17676 | 18:08:54 INFO - PID 17676 | [#3] mootools.html Cycles:180 Average:10513.09 Median:2863.08 stddev:7717.53 (269.6%) stddev-sans-first:7709.20 18:08:54 INFO - PID 17676 | Values: 1459.0 1484.8 1485.8 1490.6 1493.1 16707.4 17371.6 17398.0 17400.5 17405.4 16973.3 17028.0 17091.1 17105.3 17106.1 2839.1 2865.9 2912.5 2920.3 2931.1 2856.7 2862.3 2863.9 2879.6 2882.2 2754.7 2964.7 2968.5 2971.4 2990.9 2926.8 2929.9 2931.4 2937.2 2962.2 2810.0 2846.7 2875.4 2931.9 2939.0 16627.4 16765.4 16765.6 16777.3 16781.6 8532.8 8763.9 8790.7 8800.7 8806.2 5586.0 5740.0 5771.5 5795.5 5899.7 2124.5 2155.7 2161.4 2170.8 2207.4 30050.5 30340.2 30425.1 30449.7 30521.1 8117.4 8210.1 8371.9 8442.5 8510.9 20228.6 20307.5 20317.5 20384.0 20509.2 8661.8 8818.0 8822.3 8832.1 8862.0 7847.6 7912.6 7915.6 7923.5 8073.7 5917.0 5944.6 5994.2 6006.7 6063.8 1719.7 1740.7 1742.9 1761.3 1798.5 937.7 937.7 943.6 948.9 961.9 8123.9 8134.7 8151.0 8154.9 8195.2 803.3 808.2 809.8 824.4 825.2 5105.9 5302.7 5862.7 5902.5 6070.4 24681.5 24765.8 25507.4 25520.9 25822.7 24393.0 24565.4 25100.6 25243.1 25323.2 12491.2 12497.3 12613.9 12653.4 12703.4 9271.7 9325.1 9382.8 9451.6 9475.5 20897.2 21090.3 21283.6 21463.7 21787.5 21632.6 21642.8 21737.6 21840.6 21971.7 12654.4 12727.6 12852.3 12883.7 13040.3 15238.3 15385.8 15389.8 15397.5 15422.0 11990.5 12298.9 12394.2 12421.4 12516.1 12217.9 12398.1 12522.7 12614.9 12664.0 10816.7 11028.7 11035.9 11037.8 11038.7 8049.6 8184.4 8219.3 8285.2 8308.1 8154.6 8183.8 8263.5 8313.5 8341.1 18:08:54 INFO - PID 17676 | 18:08:54 INFO - PID 17676 | [#4] prototype.html Cycles:180 Average:5674.40 Median:6244.58 stddev:1560.34 (25.0%) stddev-sans-first:1516.73 18:08:54 INFO - PID 17676 | Values: 558.7 576.8 585.6 589.1 601.4 6220.5 6238.5 6329.8 6341.5 6346.6 6250.7 6260.1 6266.3 6273.3 6307.6 5140.6 5142.9 5177.1 5187.0 5193.6 4976.4 5035.7 5143.2 5154.1 5169.6 4996.2 5017.2 5042.5 5072.3 5105.9 5009.2 5070.8 5072.4 5078.6 5100.3 4474.2 4568.2 4568.9 4594.4 4611.8 6077.4 6097.0 6153.1 6163.3 6168.4 5972.9 5994.2 6016.5 6022.6 6038.1 6690.3 6750.1 6761.5 6768.5 6790.9 5014.1 5182.9 5228.6 5229.9 5244.7 6732.2 6810.2 6899.7 6949.8 6969.2 5314.5 5342.9 5343.9 5352.4 5359.2 5363.8 5373.5 5447.1 5448.9 5458.5 5987.6 5991.7 5999.6 6000.5 6006.4 6708.9 6738.8 6744.7 6756.2 6781.5 1839.8 1846.4 1875.8 1883.6 1890.9 1300.9 1301.9 1332.9 1337.4 1340.8 6072.4 6130.8 6192.7 6216.6 6218.3 6650.7 6724.1 6741.2 6830.6 6843.6 6139.9 6183.6 6194.6 6229.0 6278.1 3547.2 3560.8 3563.3 3582.9 3608.5 7036.5 7066.7 7069.7 7073.0 7147.8 6908.2 7024.3 7043.4 7050.6 7135.4 6845.6 6858.9 6881.3 6951.4 7019.9 6702.4 6725.7 6777.7 6805.5 6810.5 6486.6 6528.8 6555.5 6616.8 6664.9 6910.2 6934.9 6955.9 6984.3 7038.9 5272.3 5299.9 5307.6 5308.9 5336.8 6533.5 6546.2 6694.1 6813.4 6903.8 6503.3 6523.2 6534.8 6609.0 6620.2 6367.9 6466.9 6530.8 6532.3 6613.3 6286.8 6343.4 6447.4 6452.7 6452.9 6501.9 6523.8 6633.4 6643.0 6686.3 6412.4 6434.7 6463.4 6480.2 6544.4 18:08:54 INFO - PID 17676 | 18:08:54 INFO - PID 17676 | [#5] yui.html Cycles:180 Average:30737.25 Median:21060.97 stddev:45323.76 (215.2%) stddev-sans-first:45395.62 18:08:54 INFO - PID 17676 | Values: 923.4 973.3 984.3 995.9 998.8 20355.8 21034.9 21049.3 21072.7 21121.6 19686.0 19966.1 20509.0 20626.9 20854.7 1021.0 1035.6 1036.3 1036.5 1036.9 1016.9 1037.9 1043.2 1045.5 1048.6 1114.0 1120.8 1122.8 1123.5 1124.2 1108.3 1116.3 1117.4 1118.3 1118.8 765.6 786.3 793.7 794.2 822.5 21535.6 21757.6 21779.7 21805.7 21827.1 22858.4 23445.6 23473.8 23670.2 23688.4 19167.6 19273.5 19274.9 19391.9 19414.6 4095.7 4117.6 4119.8 4125.1 4125.5 171589.0 172683.0 173668.0 173946.0 174162.0 16920.2 17214.7 17298.4 17418.3 17429.3 33016.7 33659.5 33691.5 34094.8 34159.7 9473.6 9880.4 9917.3 9979.3 9990.7 4741.9 4859.2 4980.0 4981.8 4983.9 6084.8 6194.8 6198.2 6199.2 6213.8 1124.0 1141.8 1162.5 1170.4 1174.2 744.7 756.3 766.5 779.7 779.8 13421.4 13822.6 14140.7 15076.8 15121.3 725.6 730.3 737.0 744.6 751.6 6193.8 6301.9 6339.3 6368.9 6379.0 155015.0 158823.0 161503.0 161961.2 167742.0 115554.0 115627.4 130533.0 136235.0 140937.0 120825.0 121022.0 121456.4 122329.0 122876.0 13707.8 14563.3 14612.2 14637.3 14822.2 56659.4 56977.7 57818.7 57870.4 58215.4 97238.0 97652.0 97943.0 101528.5 101873.5 20760.7 21298.8 21302.0 21475.2 21577.9 23772.2 23852.3 23873.5 23962.0 24608.1 20117.5 20182.7 20437.3 20564.5 21794.1 21116.5 21248.0 21450.6 21470.1 21604.7 20942.3 21463.7 21792.5 21891.0 22074.8 15174.3 15408.5 15664.0 16077.8 16519.3 15411.7 15790.5 15863.1 15913.1 16000.8 18:08:54 INFO - PID 17676 | -------- Summary: end -------- 18:08:54 INFO - PID 17676 | 18:08:55 INFO - TEST-INFO | 17676: exit 0 18:08:55 INFO - TEST-OK | dromaeo_css | took 1107804ms 18:08:55 INFO - TEST-START | kraken 18:08:55 INFO - Initialising browser for kraken test... 18:08:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35504/getInfo.html -profile /tmp/tmpdrR0xB/profile 18:08:55 INFO - TEST-INFO | started process 18081 (/builds/slave/test/build/application/firefox/firefox http://localhost:35504/getInfo.html) 18:09:00 INFO - TEST-INFO | 18081: exit 0 18:09:00 INFO - Browser initialized. 18:09:00 INFO - Running cycle 1/1 for kraken test... 18:09:00 INFO - Using env: {'DISPLAY': ':0', 18:09:00 INFO - 'HOME': '/home/cltbld', 18:09:00 INFO - 'JSGC_DISABLE_POISONING': '1', 18:09:00 INFO - 'LANG': 'en_US.UTF-8', 18:09:00 INFO - 'LANGUAGE': 'en_US:en', 18:09:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:09:00 INFO - 'LOGNAME': 'cltbld', 18:09:00 INFO - 'MAIL': '/var/mail/cltbld', 18:09:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:09:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:09:00 INFO - 'MOZ_CRASHREPORTER': '1', 18:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:09:00 INFO - 'MOZ_NO_REMOTE': '1', 18:09:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:00 INFO - 'NO_EM_RESTART': '1', 18:09:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:00 INFO - 'PWD': '/builds/slave/test', 18:09:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:09:00 INFO - 'RUST_BACKTRACE': 'full', 18:09:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:09:00 INFO - 'SHELL': '/bin/bash', 18:09:00 INFO - 'SHLVL': '1', 18:09:00 INFO - 'STYLO_FORCE_DISABLED': '1', 18:09:00 INFO - 'TERM': 'linux', 18:09:00 INFO - 'TMOUT': '86400', 18:09:00 INFO - 'USER': 'cltbld', 18:09:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546', 18:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:00 INFO - '_': '/tools/buildbot/bin/python'} 18:09:00 INFO - TEST-INFO | started process 18354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdrR0xB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:09:01 INFO - PID 18354 | 18:09:01 INFO - PID 18354 | (/builds/slave/test/build/application/firefox/firefox:18405): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:09:01 INFO - PID 18354 | 18:09:11 INFO - PID 18354 | RSS: Main: 146444288 18:09:11 INFO - PID 18354 | 18:09:14 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35504/tests/kraken/driver.html?testName=audio-beat-detection) 18:09:15 INFO - PID 18354 | RSS: Main: 153051136 18:09:15 INFO - PID 18354 | 18:09:17 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35504/tests/kraken/driver.html?testName=audio-dft) 18:09:18 INFO - PID 18354 | RSS: Main: 153440256 18:09:18 INFO - PID 18354 | 18:09:21 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35504/tests/kraken/driver.html?testName=audio-fft) 18:09:21 INFO - PID 18354 | RSS: Main: 148946944 18:09:21 INFO - PID 18354 | 18:09:23 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35504/tests/kraken/driver.html?testName=audio-oscillator) 18:09:24 INFO - PID 18354 | RSS: Main: 149491712 18:09:24 INFO - PID 18354 | 18:09:26 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35504/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:09:27 INFO - PID 18354 | RSS: Main: 149598208 18:09:27 INFO - PID 18354 | 18:09:30 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35504/tests/kraken/driver.html?testName=imaging-darkroom) 18:09:30 INFO - PID 18354 | RSS: Main: 149975040 18:09:30 INFO - PID 18354 | 18:09:34 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35504/tests/kraken/driver.html?testName=imaging-desaturate) 18:09:34 INFO - PID 18354 | RSS: Main: 150937600 18:09:34 INFO - PID 18354 | 18:09:37 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35504/tests/kraken/driver.html?testName=json-parse-financial) 18:09:38 INFO - PID 18354 | RSS: Main: 152403968 18:09:38 INFO - PID 18354 | 18:09:39 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35504/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:09:40 INFO - PID 18354 | RSS: Main: 152088576 18:09:40 INFO - PID 18354 | 18:09:41 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35504/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:09:42 INFO - PID 18354 | RSS: Main: 152350720 18:09:42 INFO - PID 18354 | 18:09:44 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35504/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:09:45 INFO - PID 18354 | RSS: Main: 149278720 18:09:45 INFO - PID 18354 | 18:09:47 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35504/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:09:48 INFO - PID 18354 | RSS: Main: 149266432 18:09:48 INFO - PID 18354 | 18:09:50 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35504/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:09:51 INFO - PID 18354 | RSS: Main: 150253568 18:09:51 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | Cycle 1(1): loaded http://localhost:35504/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35504/tests/kraken/driver.html?testName=ai-astar) 18:09:53 INFO - PID 18354 | RSS: Main: 151117824 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | __start_tp_report 18:09:53 INFO - PID 18354 | _x_x_mozilla_page_load 18:09:53 INFO - PID 18354 | _x_x_mozilla_page_load_details 18:09:53 INFO - PID 18354 | |i|pagename|runs| 18:09:53 INFO - PID 18354 | |0;ai-astar;107;105;105;105;107;108;104;104;104;105 18:09:53 INFO - PID 18354 | |1;audio-beat-detection;111;110;109;112;111;113;111;111;110;110 18:09:53 INFO - PID 18354 | |2;audio-dft;163;163;162;160;158;162;160;162;161;166 18:09:53 INFO - PID 18354 | |3;audio-fft;73;81;72;72;73;73;73;73;75;73 18:09:53 INFO - PID 18354 | |4;audio-oscillator;78;78;77;77;79;77;77;77;78;77 18:09:53 INFO - PID 18354 | |5;imaging-gaussian-blur;113;114;114;114;113;113;113;116;114;114 18:09:53 INFO - PID 18354 | |6;imaging-darkroom;151;148;149;153;150;150;149;150;150;151 18:09:53 INFO - PID 18354 | |7;imaging-desaturate;95;99;95;94;95;94;94;94;93;94 18:09:53 INFO - PID 18354 | |8;json-parse-financial;42;43;42;43;43;43;43;44;45;42 18:09:53 INFO - PID 18354 | |9;json-stringify-tinderbox;38;38;37;39;38;37;38;38;38;38 18:09:53 INFO - PID 18354 | |10;stanford-crypto-aes;72;69;69;69;70;71;69;68;78;69 18:09:53 INFO - PID 18354 | |11;stanford-crypto-ccm;104;103;103;105;104;102;108;107;106;97 18:09:53 INFO - PID 18354 | |12;stanford-crypto-pbkdf2;151;147;150;160;144;145;152;152;147;153 18:09:53 INFO - PID 18354 | |13;stanford-crypto-sha256-iterative;58;58;57;58;59;57;57;58;57;57 18:09:53 INFO - PID 18354 | __end_tp_report 18:09:53 INFO - PID 18354 | __start_cc_report 18:09:53 INFO - PID 18354 | _x_x_mozilla_cycle_collect,728 18:09:53 INFO - PID 18354 | __end_cc_report 18:09:53 INFO - PID 18354 | __startTimestamp1506992993427__endTimestamp 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | ------- Summary: start ------- 18:09:53 INFO - PID 18354 | Number of tests: 14 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#0] ai-astar Cycles:10 Average:105.40 Median:105.00 stddev:1.43 (1.4%) stddev-sans-first:1.39 18:09:53 INFO - PID 18354 | Values: 107.0 105.0 105.0 105.0 107.0 108.0 104.0 104.0 104.0 105.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#1] audio-beat-detection Cycles:10 Average:110.80 Median:111.00 stddev:1.14 (1.0%) stddev-sans-first:1.20 18:09:53 INFO - PID 18354 | Values: 111.0 110.0 109.0 112.0 111.0 113.0 111.0 111.0 110.0 110.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:2.16 (1.3%) stddev-sans-first:2.24 18:09:53 INFO - PID 18354 | Values: 163.0 163.0 162.0 160.0 158.0 162.0 160.0 162.0 161.0 166.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#3] audio-fft Cycles:10 Average:73.80 Median:73.00 stddev:2.66 (3.6%) stddev-sans-first:2.80 18:09:53 INFO - PID 18354 | Values: 73.0 81.0 72.0 72.0 73.0 73.0 73.0 73.0 75.0 73.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:77.50 stddev:0.71 (0.9%) stddev-sans-first:0.73 18:09:53 INFO - PID 18354 | Values: 78.0 78.0 77.0 77.0 79.0 77.0 77.0 77.0 78.0 77.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 18:09:53 INFO - PID 18354 | Values: 113.0 114.0 114.0 114.0 113.0 113.0 113.0 116.0 114.0 114.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:1.37 (0.9%) stddev-sans-first:1.41 18:09:53 INFO - PID 18354 | Values: 151.0 148.0 149.0 153.0 150.0 150.0 149.0 150.0 150.0 151.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.50 stddev:1.64 (1.7%) stddev-sans-first:1.73 18:09:53 INFO - PID 18354 | Values: 95.0 99.0 95.0 94.0 95.0 94.0 94.0 94.0 93.0 94.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#8] json-parse-financial Cycles:10 Average:43.00 Median:43.00 stddev:0.94 (2.2%) stddev-sans-first:0.93 18:09:53 INFO - PID 18354 | Values: 42.0 43.0 42.0 43.0 43.0 43.0 43.0 44.0 45.0 42.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 18:09:53 INFO - PID 18354 | Values: 38.0 38.0 37.0 39.0 38.0 37.0 38.0 38.0 38.0 38.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#10] stanford-crypto-aes Cycles:10 Average:70.40 Median:69.50 stddev:2.91 (4.2%) stddev-sans-first:3.03 18:09:53 INFO - PID 18354 | Values: 72.0 69.0 69.0 69.0 70.0 71.0 69.0 68.0 78.0 69.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#11] stanford-crypto-ccm Cycles:10 Average:103.90 Median:105.50 stddev:3.07 (2.9%) stddev-sans-first:3.26 18:09:53 INFO - PID 18354 | Values: 104.0 103.0 103.0 105.0 104.0 102.0 108.0 107.0 106.0 97.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:151.50 stddev:4.68 (3.1%) stddev-sans-first:4.95 18:09:53 INFO - PID 18354 | Values: 151.0 147.0 150.0 160.0 144.0 145.0 152.0 152.0 147.0 153.0 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:57.60 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 18:09:53 INFO - PID 18354 | Values: 58.0 58.0 57.0 58.0 59.0 57.0 57.0 58.0 57.0 57.0 18:09:53 INFO - PID 18354 | -------- Summary: end -------- 18:09:53 INFO - PID 18354 | 18:09:53 INFO - PID 18354 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:09:54 INFO - TEST-INFO | 18354: exit 0 18:09:54 INFO - TEST-OK | kraken | took 58752ms 18:09:54 INFO - SUITE-END | took 1166s 18:09:54 INFO - Completed test suite (00:19:26) 18:09:54 INFO - javascript benchmark 18:09:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9257.801611795314, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3916.314644937135, 3920.05918579541, 3923.333033384324, 3944.3689009758446, 3948.210357928414, 6264.997600383939, 6282.340354262799, 6331.430171284584, 6355.428011478966, 6413.7755178568705, 6313.242410910697, 6333.778317758879, 6336.5247606429475, 6341.5877967932165, 6352.6188428694195, 5608.635438696492, 5654.180143879135, 5674.517665998395, 5745.052066409037, 5835.679037652927, 5776.624519406246, 5782.566307526931, 5789.102689083199, 5789.623674461168, 5842.824715258549, 5625.268715067056, 5798.7100644967795, 5855.033919403293, 5875.941240587604, 5882.970585147068, 5686.630369026, 5719.113537401709, 5751.884962300731, 5802.390748971382, 5807.2160258365, 5705.0, 5712.542996560265, 5772.076467765138, 5787.536997040227, 5801.767929282823, 6268.373162683741, 6307.810765677037, 6350.904736428957, 6383.71273292703, 6420.839479013015, 6843.144606924135, 6850.588964662136, 6879.690413931385, 6885.690143943484, 6912.585244885273, 6862.210845752752, 6957.79126626202, 6959.61722105284, 6965.303469653045, 6969.860602787967, 6349.650769207692, 6353.30113687494, 6370.0, 6452.677366131675, 6455.451286640641, 6897.758578449831, 6973.407260382823, 6989.231184569693, 7104.360607545345, 7111.217766045731, 6757.459403247728, 6780.898286525706, 6787.830304242433, 6858.074159988338, 6863.553868998499, 6859.794206173823, 6898.0, 6934.202566704894, 6956.373926346552, 6970.825729356807, 6798.116244888133, 6803.693833777492, 6862.9313706862295, 6865.347791959855, 6909.170899492093, 6737.427318677967, 6819.147606549182, 6824.146981627297, 6828.5902845829405, 6835.829104272333, 4934.407871055496, 4940.876478088005, 4983.25251212321, 4995.075910956412, 5021.322121513549, 4528.207563676344, 4533.38799262102, 4565.497795242521, 4566.88582785433, 4644.210484217691, 6357.04644303349, 6394.328595497499, 6405.231372235362, 6408.967955160194, 6410.775622853178, 6851.246362900077, 6855.897161542581, 6941.861162776716, 6944.826379340456, 6949.687264073129, 6316.494680425555, 6328.525360597881, 6397.264314603787, 6403.359664033559, 6404.103425520431, 5454.481824226692, 5513.365962914236, 5513.862153446196, 5571.275734154534, 5579.4420557944695, 7148.428125749928, 7150.070490836158, 7205.71177152908, 7233.963830180815, 7237.746678866214, 6873.347032031949, 6891.483138764513, 6967.79096627102, 6968.721251149897, 6969.2682268361095, 6975.651217439006, 7040.542364746275, 7062.540934839219, 7065.364117229474, 7120.572765634079, 6749.763758268437, 6767.221769496571, 6787.083743694538, 6824.215215250111, 6830.829229269308, 6854.280300568368, 6866.519343645897, 6875.690593923386, 6895.931040689529, 6962.651867406508, 6634.170728658918, 6635.668216589248, 6696.564723293165, 6705.228898676714, 6724.630145342053, 6537.836554086186, 6595.4393876521035, 6634.0, 6694.263631000488, 6733.93266067333, 6478.1578394808375, 6489.837754056186, 6582.210134783665, 6584.637844918576, 6594.70323835419, 6749.156355455568, 6779.559328643622, 6797.0823938767635, 6813.182418109858, 6818.454523638196, 6490.902636460552, 6514.511411644051, 6543.411093001652, 6608.140941677551, 6634.701438435379], "value": 6288.858956428079, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [938.7934654376039, 958.2669258017618, 972.922166226702, 1024.810410074136, 1027.8406846938722, 44305.77847110764, 45224.0, 45307.54692453075, 45385.546144538544, 45512.317315240216, 43311.35032974508, 45601.0, 46510.30234546476, 46610.53389466104, 46808.76595617025, 8360.91639083609, 8752.606132724042, 8772.0, 8793.428427152247, 8800.383973121883, 8551.401401901869, 8619.698310559132, 8666.263367613728, 8666.56667166639, 8679.869801952977, 8644.481331120121, 8659.393842431033, 8675.436096653697, 8713.128687131299, 8721.738347849543, 8633.784155396103, 8642.438241514314, 8656.307495400384, 8667.0, 8701.43440676354, 8552.0, 8592.613332400057, 8604.225619694194, 8614.310855131574, 8616.526091064989, 41749.165016699495, 41935.0, 42042.0, 42236.57763422357, 42275.57724422778, 3795.9240815183816, 3815.3323168445413, 3843.385058390672, 3848.9415410761985, 3855.6529912307747, 35184.64815351839, 35240.29519409623, 35255.11862203466, 35284.64715352839, 35323.4701479478, 5352.759125839347, 5369.0604144274985, 5413.188021796723, 5435.374931882805, 5590.077637189859, 228919.0, 232022.0, 235564.0, 238058.0, 238227.0, 53316.0, 53342.0, 53469.732651337275, 53471.73264133732, 53533.73233133809, 56797.0, 57029.71485142548, 57041.14438283429, 57158.42841571531, 57197.42802571921, 17120.315187392363, 17248.827511724972, 17262.568435788955, 17273.0, 17488.825111748974, 14084.084534505224, 14088.506902258372, 14088.506902258578, 14091.577252682437, 14095.154290742588, 14578.927105364406, 14630.634234144232, 14651.633709157357, 14708.852911470749, 14766.187859667607, 5373.596980226499, 5438.91841622376, 5459.344878614592, 5577.832665020056, 5627.5779316551425, 1087.1683162380784, 1088.5591335509132, 1103.4372470040337, 1107.058999850121, 1111.2721167635211, 24599.262022139363, 24605.261842144766, 24667.506649866904, 24681.259562213163, 24861.378465538506, 1211.5093387178206, 1217.963461096151, 1220.530095913062, 1233.210745123122, 1236.5424792826711, 13032.218066916015, 13130.080894337305, 13182.274974876282, 13229.140105893086, 13248.27134507592, 295897.0, 296073.0, 297045.0, 297428.0, 297881.0, 59467.0, 60097.399026010055, 60119.0, 60169.097463538084, 60206.397936020076, 1531.954041378738, 1537.1084770833113, 1548.0866288889608, 1567.0597641415059, 1576.7004269188817, 24464.510709785347, 24559.386015349046, 24625.261242162764, 24755.504889902462, 24812.131575394775, 41642.58357416387, 41832.16335673209, 41953.37069943892, 41977.790111049246, 42058.36912446377, 249678.0, 250755.0, 251393.0, 251456.0, 251969.0, 37605.0, 37983.43024854684, 38170.23659526849, 38465.2306953865, 38676.0, 48302.75848620734, 48318.758406207744, 48745.268820967, 48920.5107948916, 49077.50922490729, 35773.284534309685, 35975.0, 36115.819420903776, 36264.0, 36598.0, 35969.82015090012, 36181.457278140326, 36568.817155914054, 36603.816980914926, 36630.0, 39126.6087339123, 40593.391099134125, 40604.79697601493, 40785.1842963145, 40917.795411023944, 35066.298674025864, 35338.64661353456, 35396.646033539335, 35592.64407355997, 35654.28691426105, 24750.38124046913, 24873.62689559622, 25065.248042558753, 25338.36654083589, 25568.360790980376], "value": 19045.15731054103, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.2291942370597, 631.6210273835698, 638.1066506890353, 640.1837656987337, 643.8486955565443, 23366.88316558419, 23397.766022339772, 24629.876850615743, 24730.134445294396, 24898.875505622447, 25164.49671006579, 26627.201183964513, 26639.0, 26646.200613981564, 26661.466770664625, 6581.341865813416, 6600.702968366411, 6717.059611654372, 6726.058351830748, 6726.529142959995, 6523.6738163091895, 6594.93405065948, 6880.690368933385, 6888.070110535064, 6949.652517374137, 6904.102466679325, 6906.0, 6908.101946746916, 6909.792706218822, 6919.377256046955, 6677.131972843548, 6872.244053154149, 6915.997180408837, 6916.515843890929, 6939.965300173517, 6479.481641468718, 6487.481001519867, 6490.707918143695, 6495.220573531159, 6496.8700625987685, 30366.240843978856, 31013.0, 31017.534736978963, 31036.224094397596, 31087.067387978397, 2169.1540299283292, 2248.6964259824877, 2253.2001139595372, 2254.1208928517726, 2255.210676263311, 19877.403677889688, 21058.789412105834, 21154.682679759815, 21270.680939785914, 21275.0, 2524.1670248817845, 2578.613208018812, 2590.1452520668136, 2679.933001674954, 2684.7583717465327, 131014.3449282757, 137371.0, 154657.0, 163037.18481407635, 163306.18346908188, 16359.42742004048, 16643.167841607872, 16761.245743941552, 16863.662726745642, 16992.660146796996, 26322.736772632412, 26435.603465948025, 26447.206583802516, 26491.602625960626, 26530.0, 10338.844917326247, 10441.947790261152, 10547.630832920811, 10591.417472038958, 10631.84052239217, 9355.345125841262, 9390.5304734763, 9484.715458536255, 9530.380525265835, 9602.567884445216, 9716.659916902874, 9796.608135674636, 9923.1069203772, 10163.542640581192, 10295.227857910686, 2957.8668959896854, 2961.188069387246, 2995.4458425190974, 3086.2592977685645, 3124.5469406935867, 1031.2059714020313, 1031.886492485826, 1045.5347370420243, 1052.273930987616, 1061.3048453263125, 20149.597008059758, 20495.385138445872, 20601.48496287605, 20871.269505567536, 21033.15867365319, 1081.853949716794, 1102.7518808268076, 1108.3516143056402, 1109.944502774858, 1117.1565468071553, 11277.54889804415, 11355.375454349925, 11360.318380897173, 11375.829362559569, 11472.77054458906, 586149.0, 587283.0, 599961.0, 602910.0, 629481.0, 126365.0, 128685.0, 129646.0, 130442.0, 131097.0, 1184.59131599598, 1219.3415555600054, 1220.462996281651, 1228.748106638137, 1228.9078319126102, 18278.268869245083, 18432.0, 18493.81506184921, 18856.622867542847, 18906.905465472584, 64350.67824661034, 64629.0, 64863.67568162129, 65116.67441662761, 65961.0, 84827.5758621203, 84904.57547712221, 85311.0, 86135.569322153, 86374.0, 15801.288941997867, 16082.195890205678, 16242.106684132486, 16256.67486650284, 16302.103384313503, 23758.88120559386, 23893.880530597235, 23995.52008959846, 24121.276361709177, 24198.032078716653, 18756.155972980974, 18813.623727525646, 19000.809991900456, 19190.0, 19195.80804191996, 17688.729803430575, 17730.645387092445, 17788.0, 17894.373696920546, 18027.369042083465, 19280.4215873524, 19565.0, 19831.30590429328, 19863.106160222535, 19920.60158796787, 15701.0, 15759.133247671489, 15859.682806344039, 15865.52403427899, 15867.603309917344, 17966.191521381308, 19081.236750529824, 19083.90458047701, 19115.0, 19195.232190712217], "value": 12864.765079784034, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.9708205835884, 1484.8218213814337, 1485.7845612386204, 1490.5751860719697, 1493.111598598834, 16707.415240466587, 17371.56571085722, 17398.043107629106, 17400.47798566042, 17405.390811321606, 16973.3210671573, 17028.0, 17091.05999170045, 17105.31578736849, 17106.059166745825, 2839.119872839416, 2865.899693510733, 2912.519434293339, 2920.2553348896004, 2931.106012666136, 2856.742893139617, 2862.298736809474, 2863.871125799344, 2879.5680647902773, 2882.192985963923, 2754.6832114306812, 2964.7035296470394, 2968.5250359942415, 2971.4205729882574, 2990.8953186638473, 2926.765858731307, 2929.9414011719646, 2931.4430258250973, 2937.1922721251613, 2962.200205944394, 2809.9884041744954, 2846.7153284671576, 2875.43928933858, 2931.868065937038, 2938.9706102938912, 16627.41804036865, 16765.413210537696, 16765.580860478465, 16777.32890684371, 16781.580460488465, 8532.78668033298, 8763.868541971875, 8790.692325768632, 8800.735977920673, 8806.163414475615, 5586.0, 5739.971300143473, 5771.480566748971, 5795.478406943354, 5899.73451194693, 2124.5007423255524, 2155.687425323335, 2161.3939510577493, 2170.815480684144, 2207.404000919759, 30050.54924176139, 30340.24149396283, 30425.087247382613, 30449.695503044906, 30521.08436746901, 8117.391195660349, 8210.096889342167, 8371.874421883676, 8442.493450392873, 8510.872336914952, 20228.595428091357, 20307.492312692004, 20317.49206269855, 20384.0, 20509.17963281452, 8661.826763464695, 8818.0, 8822.25010874083, 8832.116788321246, 8861.955690221508, 7847.607619618996, 7912.643931023118, 7915.643796029078, 7923.484973476706, 8073.6770529178175, 5917.0, 5944.554158438134, 5994.1608174855555, 6006.699665016732, 6063.787767428119, 1719.7162468192607, 1740.6518696260798, 1742.8867123637176, 1761.2866788950496, 1798.5233913013062, 937.7186843946789, 937.723371605378, 943.6366998705548, 948.9288303377136, 961.8605302231138, 8123.918760812435, 8134.715284964997, 8151.0, 8154.8776768348525, 8195.180481951877, 803.333233416263, 808.2402541610867, 809.8177909970327, 824.3652387661467, 825.1500954017372, 5105.9489405106215, 5302.68183908959, 5862.677552734641, 5902.498287645598, 6070.362611925772, 24681.506369872863, 24765.752342476346, 25507.36231594188, 25520.872395638275, 25822.74177258241, 24393.0, 24565.38586535351, 25100.623490647657, 25243.11649092273, 25323.240302790946, 12491.188072775241, 12497.250164989948, 12613.873861261454, 12653.430595623218, 12703.42834572428, 9271.67549135777, 9325.114114159143, 9382.765430864283, 9451.574679139592, 9475.47884866339, 20897.223735982003, 21090.261840835497, 21283.574328513652, 21463.678044829026, 21787.45531361665, 21632.567348652625, 21642.783572164077, 21737.565248695253, 21840.563188736454, 21971.670424943957, 12654.430550625428, 12727.618171454871, 12852.293123877902, 12883.677908052374, 13040.347982601023, 15238.314275857834, 15385.769213461583, 15389.84610153929, 15397.538073857802, 15422.0, 11990.460429280529, 12298.938505307417, 12394.194377365442, 12421.441035153259, 12516.12387132892, 12217.93891030539, 12398.13213075076, 12522.686932826387, 12614.873851261736, 12664.0, 10816.67549973502, 11028.669139925814, 11035.944820276169, 11037.83443248368, 11038.668839934815, 8049.597520123853, 8184.386171037315, 8219.260266576037, 8285.171482851667, 8308.086110527716, 8154.551499667576, 8183.79540511492, 8263.545504997282, 8313.542755148525, 8341.124181960808], "value": 7372.110341735559, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6815515156362, 576.8154190658989, 585.628126139901, 589.0751520113422, 601.3505414152716, 6220.50235981121, 6238.469730072944, 6329.810105696825, 6341.460975817055, 6346.587471814329, 6250.687465626723, 6260.123582698426, 6266.279377871546, 6273.309935907058, 6307.558470907038, 5140.588752899768, 5142.948570514303, 5177.145770947789, 5187.04039752647, 5193.584513238932, 4976.402831660206, 5035.697858128506, 5143.151380022292, 5154.098032844256, 5169.56058735008, 4996.150654388744, 5017.247412888059, 5042.495750424947, 5072.3405957225505, 5105.923411148836, 5009.2486127080865, 5070.797168113271, 5072.391313042459, 5078.64449488536, 5100.33695619569, 4474.194644963905, 4568.177728008957, 4568.862934111982, 4594.379758732562, 4611.838585649486, 6077.392260773887, 6097.0, 6153.138560601519, 6163.291221509494, 6168.383161683841, 5972.880542389128, 5994.220751302303, 6016.465801220661, 6022.608530445507, 6038.124471951543, 6690.264070952191, 6750.097458093018, 6761.492888033417, 6768.458523318122, 6790.932090679079, 5014.097462456756, 5182.922256166161, 5228.581713462914, 5229.947700522984, 5244.711540865251, 6732.158480189976, 6810.182778066664, 6899.7235511430545, 6949.810809595012, 6969.247147376758, 5314.458806945942, 5342.904704535561, 5343.919841202385, 5352.357717073976, 5359.249705041298, 5363.846772943836, 5373.543248823816, 5447.12845944647, 5448.91826622601, 5458.4814442627885, 5987.64074155552, 5991.670458124845, 5999.5800293979, 6000.549958753024, 6006.369331220247, 6708.932910670831, 6738.764143254963, 6744.6627668616375, 6756.189257289157, 6781.525293229525, 1839.8252166044472, 1846.3999200259968, 1875.7655293088364, 1883.5667796406904, 1890.9149088290785, 1300.8829205371562, 1301.9088663793443, 1332.9200247985152, 1337.411538922871, 1340.8323959505062, 6072.4398124335485, 6130.754769809158, 6192.721327540272, 6216.564840461125, 6218.284897236876, 6650.6698660267175, 6724.125863637793, 6741.224759152662, 6830.59016459014, 6843.589384636938, 6139.907901381483, 6183.628982260989, 6194.628322300677, 6229.0, 6278.121063051085, 3547.2373439710586, 3560.8041557714573, 3563.2540055373197, 3582.9104272393397, 3608.4767708682093, 7036.472264580177, 7066.7173313066905, 7069.681864316118, 7072.964635176894, 7147.785566433015, 6908.240093589701, 7024.262452442522, 7043.401310888632, 7050.5769653820935, 7135.394536229307, 6845.589264644137, 6858.897116543156, 6881.277465866112, 6951.350540965932, 7019.858943022427, 6702.36327548882, 6725.697343619451, 6777.661116944035, 6805.455563554805, 6810.523263371517, 6486.578372405778, 6528.836779080561, 6555.508336874658, 6616.8345791355605, 6664.933350666432, 6910.239873613999, 6934.930650693428, 6955.947995341286, 6984.311040249642, 7038.859222815618, 5272.314599102092, 5299.947000529945, 5307.6284660073425, 5308.946910530845, 5336.839894803162, 6533.542652014314, 6546.24718157418, 6694.054615968958, 6813.386795188457, 6903.827404314932, 6503.317151699003, 6523.18460192476, 6534.759304863748, 6608.966955165193, 6620.205575330799, 6367.860890421263, 6466.902996454963, 6530.8367290818105, 6532.346765323429, 6613.280547057703, 6286.77407905454, 6343.429091381798, 6447.3552644735155, 6452.709628066842, 6452.870942581216, 6501.869962600627, 6523.804285871432, 6633.402993730394, 6642.966785166043, 6686.264510903894, 6412.35876412355, 6434.678266086583, 6463.418292353711, 6480.157579514633, 6544.3782840630065], "value": 5230.60951175992, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.3674932671125, 973.260322155162, 984.3011461862078, 995.9153471954884, 998.8152191844509, 20355.796442035593, 21034.894825525887, 21049.263275785368, 21072.683909741365, 21121.57756844866, 19686.0, 19966.101525431353, 20509.0, 20626.89686551569, 20854.687179692315, 1021.0300214795936, 1035.5754140802273, 1036.3367444835312, 1036.533559898045, 1036.9377837329746, 1016.9389836609827, 1037.901399367059, 1043.1706793099504, 1045.4720366215051, 1048.6120135549857, 1114.0419239454063, 1120.7814476177148, 1122.764219513903, 1123.4831977290455, 1124.2018167101369, 1108.3405373802534, 1116.2911551164987, 1117.4412793603199, 1118.2954738514684, 1118.7538741476903, 765.6324964017247, 786.3276898251969, 793.7380664380798, 794.1780257433586, 822.461287856455, 21535.569288614297, 21757.564848703096, 21779.67330490044, 21805.67291490629, 21827.126914923385, 22858.428539286484, 23445.648315275284, 23473.7652623475, 23670.17154399605, 23688.40778980522, 19167.61664766711, 19273.518162045923, 19274.903625481784, 19391.90304048485, 19414.611707765907, 4095.692823038254, 4117.5882411758585, 4119.752814831089, 4125.1131006833375, 4125.463689720347, 171588.99999999875, 172683.0, 173668.0, 173946.0, 174162.0, 16920.238589263514, 17214.708896832537, 17298.394556190724, 17418.303267869396, 17429.302827886742, 33016.66983330184, 33659.495107573406, 33691.49462758061, 34094.82952585221, 34159.65840341614, 9473.621055157717, 9880.35777674449, 9917.30578859473, 9979.251556133318, 9990.650327238513, 4741.857744267678, 4859.246816743411, 4979.950200498021, 4981.775820088104, 4983.875403114951, 6084.787032453843, 6194.783182588588, 6198.163247961467, 6199.194104766351, 6213.844653883599, 1123.9606613768478, 1141.7887690777234, 1162.5001249462812, 1170.414792603698, 1174.2308787744041, 744.6872313628289, 756.3004221095465, 766.4558163703832, 779.653054390802, 779.8011507065776, 13421.396037178156, 13822.585322440344, 14140.717185656229, 15076.773848392282, 15121.319540620478, 725.6480606905646, 730.3426915775844, 736.9631518424058, 744.6016381236012, 751.5866273549526, 6193.783217587453, 6301.873962520724, 6339.302676705559, 6368.872622547523, 6379.043143528508, 155015.0, 158823.0, 161503.0, 161961.19019404828, 167742.0, 115554.0, 115627.42186289014, 130533.0, 136235.0, 140937.0, 120825.0, 121022.0, 121456.39271803584, 122329.0, 122875.99999999821, 13707.794383084061, 14563.344649490586, 14612.19632920157, 14637.341319640855, 14822.184779836782, 56659.43340566542, 56977.71511142418, 57818.7109064452, 57870.4212957865, 58215.417845822696, 97238.0, 97652.0, 97943.0, 101528.49235753773, 101873.49063254637, 20760.68858967147, 21298.78701212968, 21302.0, 21475.248366307103, 21577.892110539346, 23772.167974120825, 23852.284431467084, 23873.52252954966, 23962.0, 24608.138715144883, 20117.497062572966, 20182.69725954141, 20437.284695035603, 20564.485887852923, 21794.128234870426, 21116.47208819792, 21248.0, 21450.570988579828, 21470.14119435205, 21604.67592986075, 20942.267020654202, 21463.678044829652, 21792.45518862041, 21891.0, 22074.779252207274, 15174.31715572824, 15408.537743867702, 15664.0, 16077.8151889263, 16519.256633451285, 15411.69176616439, 15790.526284211492, 15863.127527986071, 15913.124778137313, 16000.8399916004], "value": 10595.409325755827, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1350.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 105.0, 105.0, 107.0, 108.0, 104.0, 104.0, 104.0, 105.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 109.0, 112.0, 111.0, 113.0, 111.0, 111.0, 110.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 160.0, 158.0, 162.0, 160.0, 162.0, 161.0, 166.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 72.0, 72.0, 73.0, 73.0, 73.0, 73.0, 75.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 77.0, 79.0, 77.0, 77.0, 77.0, 78.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 116.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 149.0, 153.0, 150.0, 150.0, 149.0, 150.0, 150.0, 151.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 43.0, 42.0, 43.0, 43.0, 43.0, 43.0, 44.0, 45.0, 42.0], "value": 43.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 39.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 69.0, 69.0, 70.0, 71.0, 69.0, 68.0, 78.0, 69.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 103.0, 103.0, 105.0, 104.0, 102.0, 108.0, 107.0, 106.0, 97.0], "value": 103.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 147.0, 150.0, 160.0, 144.0, 145.0, 152.0, 152.0, 147.0, 153.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 59.0, 57.0, 57.0, 58.0, 57.0, 57.0], "value": 57.6, "unit": "score"}]}]} 18:09:54 INFO - Return code: 0 18:09:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:09:54 INFO - # TBPL SUCCESS # 18:09:54 INFO - Running post-action listener: _package_coverage_data 18:09:54 INFO - Running post-action listener: _resource_record_post_action 18:09:54 INFO - [mozharness: 2017-10-03 01:09:54.722622Z] Finished run-tests step (success) 18:09:54 INFO - Running post-run listener: _resource_record_post_run 18:09:54 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 425984; Write bytes: 331845632; Read time: 192; Write time: 164264 18:09:54 INFO - TinderboxPrint: CPU usage
13.1% 18:09:54 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 192 18:09:54 INFO - TinderboxPrint: I/O write bytes / time
331,845,632 / 164,264 18:09:54 INFO - TinderboxPrint: CPU idle
8,211.3 (86.9%) 18:09:54 INFO - TinderboxPrint: CPU user
1,188.0 (12.6%) 18:09:54 INFO - TinderboxPrint: Swap in / out
0 / 0 18:09:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13422592; Read time: 0; Write time: 1924 18:09:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:09:54 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 425984; Write bytes: 318423040; Read time: 192; Write time: 162340 18:09:55 INFO - Running post-run listener: _upload_blobber_files 18:09:55 INFO - Blob upload gear active. 18:09:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:09:55 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 18:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:09:55 INFO - (blobuploader) - INFO - Open directory for files ... 18:09:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 18:09:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 18:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:09:56 INFO - (blobuploader) - INFO - Done attempting. 18:09:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:09:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:10:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:08 INFO - (blobuploader) - INFO - Done attempting. 18:10:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 18:10:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 18:10:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:09 INFO - (blobuploader) - INFO - Done attempting. 18:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:10:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:10 INFO - (blobuploader) - INFO - Done attempting. 18:10:10 INFO - (blobuploader) - INFO - Iteration through files over. 18:10:10 INFO - Return code: 0 18:10:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:10:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:10:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b22927a0fc6cdfc1adc6e2ed27d9b0997a80162d2bd5b25713f677b2414809b03483ef0b3404764c7ac2c0e3d48aa1239564956c35ab95c31023d788270076", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/439286636eed5c668752c78ff40eb6e51498d642ddf23ca3b1d32cab251b97c528af28294f79613f0d6bb8cf47c25b78e9f9d11f44a90197e3aded0ecf4c5ecf", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fb194f9ce1254f21aa2dd73984834541683cbcdc306d4ec17ab8c7cf57a0d0a6a9a3d7d2ffad3d6340decdf0e9872aaa899898e072c6cdd5f2586d72387ea30", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56fe84dafa3308ef8ad2dcbbeb1a1a805503b4e0ee824747b1e7836e74e55ab16e0efdef9fa7f5efb8aab24cbe4c55ed875b3969e476090c003218663c2ff7a4"} 18:10:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:10:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:10:10 INFO - Contents: 18:10:10 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b22927a0fc6cdfc1adc6e2ed27d9b0997a80162d2bd5b25713f677b2414809b03483ef0b3404764c7ac2c0e3d48aa1239564956c35ab95c31023d788270076", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/439286636eed5c668752c78ff40eb6e51498d642ddf23ca3b1d32cab251b97c528af28294f79613f0d6bb8cf47c25b78e9f9d11f44a90197e3aded0ecf4c5ecf", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fb194f9ce1254f21aa2dd73984834541683cbcdc306d4ec17ab8c7cf57a0d0a6a9a3d7d2ffad3d6340decdf0e9872aaa899898e072c6cdd5f2586d72387ea30", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56fe84dafa3308ef8ad2dcbbeb1a1a805503b4e0ee824747b1e7836e74e55ab16e0efdef9fa7f5efb8aab24cbe4c55ed875b3969e476090c003218663c2ff7a4"} 18:10:10 INFO - Running post-run listener: copy_logs_to_upload_dir 18:10:10 INFO - Copying logs to upload dir... 18:10:10 INFO - mkdir: /builds/slave/test/build/upload/logs 18:10:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.799046 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-10-02 18:10:10.297979) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 18:10:10.301211) ========= 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=3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546 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/sha512/92b22927a0fc6cdfc1adc6e2ed27d9b0997a80162d2bd5b25713f677b2414809b03483ef0b3404764c7ac2c0e3d48aa1239564956c35ab95c31023d788270076", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/439286636eed5c668752c78ff40eb6e51498d642ddf23ca3b1d32cab251b97c528af28294f79613f0d6bb8cf47c25b78e9f9d11f44a90197e3aded0ecf4c5ecf", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fb194f9ce1254f21aa2dd73984834541683cbcdc306d4ec17ab8c7cf57a0d0a6a9a3d7d2ffad3d6340decdf0e9872aaa899898e072c6cdd5f2586d72387ea30", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56fe84dafa3308ef8ad2dcbbeb1a1a805503b4e0ee824747b1e7836e74e55ab16e0efdef9fa7f5efb8aab24cbe4c55ed875b3969e476090c003218663c2ff7a4"} build_url:https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/GvTuDUuVRuaZlRJDpMYY1Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b22927a0fc6cdfc1adc6e2ed27d9b0997a80162d2bd5b25713f677b2414809b03483ef0b3404764c7ac2c0e3d48aa1239564956c35ab95c31023d788270076", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/439286636eed5c668752c78ff40eb6e51498d642ddf23ca3b1d32cab251b97c528af28294f79613f0d6bb8cf47c25b78e9f9d11f44a90197e3aded0ecf4c5ecf", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fb194f9ce1254f21aa2dd73984834541683cbcdc306d4ec17ab8c7cf57a0d0a6a9a3d7d2ffad3d6340decdf0e9872aaa899898e072c6cdd5f2586d72387ea30", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56fe84dafa3308ef8ad2dcbbeb1a1a805503b4e0ee824747b1e7836e74e55ab16e0efdef9fa7f5efb8aab24cbe4c55ed875b3969e476090c003218663c2ff7a4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 18:10:10.330082) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 18:10:10.330406) ========= 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=3836458cccd887f2d2de3cf1000001de-1506991271.657902-890252546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 18:10:10.415897) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 18:10:10.416209) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 18:10:10.416497) ========= ========= Total master_lag: 0.20 =========