builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1504345156.21 results: success (0) revision: b01a7e57425b5fe791ab091f5c33e069890753fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-02 02:39:16.212509) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-02 02:39:16.212976) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-02 02:39:16.213270) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-02 02:39:16.244815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:39:16.245114) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-02 02:39:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.2M=0.001s 2017-09-02 02:39:16 (20.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110597 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:39:16.375368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:39:16.375694) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021353 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:39:16.428920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-02 02:39:16.429360) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b01a7e57425b5fe791ab091f5c33e069890753fb --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 b01a7e57425b5fe791ab091f5c33e069890753fb --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=78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-02 02:39:16,532 truncating revision to first 12 chars 2017-09-02 02:39:16,532 Setting DEBUG logging. 2017-09-02 02:39:16,532 attempt 1/10 2017-09-02 02:39:16,532 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b01a7e57425b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-02 02:39:17,483 unpacking tar archive at: mozilla-central-b01a7e57425b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.308627 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-02 02:39:17.760191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-02 02:39:17.760785) ========= script_repo_revision: b01a7e57425b5fe791ab091f5c33e069890753fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-02 02:39:17.761559) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-02 02:39:17.765149) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-02 02:39:17.782244) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-09-02 02:39:17.782911) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:39:18 INFO - MultiFileLogger online at 20170902 02:39:18 in /builds/slave/test 02:39:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:39:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:39:18 INFO - {'append_to_log': False, 02:39:18 INFO - 'base_work_dir': '/builds/slave/test', 02:39:18 INFO - 'blob_upload_branch': 'Firefox', 02:39:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:39:18 INFO - 'branch': 'Firefox', 02:39:18 INFO - 'buildbot_json_path': 'buildprops.json', 02:39:18 INFO - 'code_coverage': False, 02:39:18 INFO - 'config_files': ('talos/linux_config.py',), 02:39:18 INFO - 'default_actions': ('clobber', 02:39:18 INFO - 'read-buildbot-config', 02:39:18 INFO - 'download-and-extract', 02:39:18 INFO - 'populate-webroot', 02:39:18 INFO - 'create-virtualenv', 02:39:18 INFO - 'install', 02:39:18 INFO - 'setup-mitmproxy', 02:39:18 INFO - 'run-tests'), 02:39:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:39:18 INFO - 'disable_ccov_upload': False, 02:39:18 INFO - 'disable_stylo': False, 02:39:18 INFO - 'download_minidump_stackwalk': True, 02:39:18 INFO - 'download_symbols': 'ondemand', 02:39:18 INFO - 'enable_stylo': False, 02:39:18 INFO - 'enable_webrender': False, 02:39:18 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:39:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:39:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:39:18 INFO - 'gecko_profile': False, 02:39:18 INFO - 'gecko_profile_interval': 0, 02:39:18 INFO - 'installer_path': 'installer.exe', 02:39:18 INFO - 'log_level': 'info', 02:39:18 INFO - 'log_name': 'talos', 02:39:18 INFO - 'log_to_console': True, 02:39:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:39:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:39:18 INFO - 'opt_config_files': (), 02:39:18 INFO - 'pip_index': False, 02:39:18 INFO - 'suite': 'dromaeojs-e10s', 02:39:18 INFO - 'system_bits': '32', 02:39:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:39:18 INFO - 'title': 'talos-linux64-ix-019', 02:39:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:39:18 INFO - 'use_talos_json': True, 02:39:18 INFO - 'verify': 'False', 02:39:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:39:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:39:18 INFO - 'work_dir': 'build'} 02:39:18 INFO - [mozharness: 2017-09-02 09:39:18.027675Z] Running clobber step. 02:39:18 INFO - Running pre-action listener: _resource_record_pre_action 02:39:18 INFO - Running main action method: clobber 02:39:18 INFO - rmtree: /builds/slave/test/build 02:39:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:39:19 INFO - Running post-action listener: _resource_record_post_action 02:39:19 INFO - [mozharness: 2017-09-02 09:39:19.049353Z] Finished clobber step (success) 02:39:19 INFO - [mozharness: 2017-09-02 09:39:19.049451Z] Running read-buildbot-config step. 02:39:19 INFO - Running pre-action listener: _resource_record_pre_action 02:39:19 INFO - Running main action method: read_buildbot_config 02:39:19 INFO - Using buildbot properties: 02:39:19 INFO - { 02:39:19 INFO - "project": "", 02:39:19 INFO - "product": "firefox", 02:39:19 INFO - "who": "archaeopteryx@coole-files.de", 02:39:19 INFO - "installer_path": "public/build/target.tar.bz2", 02:39:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:39:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:39:19 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:39:19 INFO - "stage_platform": "linux64-stylosequential", 02:39:19 INFO - "basedir": "/builds/slave/test", 02:39:19 INFO - "buildnumber": 55, 02:39:19 INFO - "platform": "ubuntu64_hw_styloseq", 02:39:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:39:19 INFO - "slavebuilddir": "test", 02:39:19 INFO - "taskId": "NOe3JLr9RVOrxYu8K4_C0g", 02:39:19 INFO - "branch": "mozilla-central", 02:39:19 INFO - "script_repo_revision": "production", 02:39:19 INFO - "revision": "b01a7e57425b5fe791ab091f5c33e069890753fb", 02:39:19 INFO - "slavename": "talos-linux64-ix-019", 02:39:19 INFO - "repo_path": "mozilla-central" 02:39:19 INFO - } 02:39:19 INFO - Finding installer, test and symbols from parent task. 02:39:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NOe3JLr9RVOrxYu8K4_C0g'}, attempt #1 02:39:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NOe3JLr9RVOrxYu8K4_C0g'}, attempt #1 02:39:19 INFO - Task dependencies: ftQy0px5TK6bx82a3KX9nw 02:39:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw'}, attempt #1 02:39:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2 02:39:20 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.test_packages.json 02:39:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.crashreporter-symbols.zip 02:39:20 INFO - Running post-action listener: _resource_record_post_action 02:39:20 INFO - [mozharness: 2017-09-02 09:39:20.423650Z] Finished read-buildbot-config step (success) 02:39:20 INFO - [mozharness: 2017-09-02 09:39:20.423867Z] Running download-and-extract step. 02:39:20 INFO - Running pre-action listener: _resource_record_pre_action 02:39:20 INFO - Running main action method: download_and_extract 02:39:20 INFO - mkdir: /builds/slave/test/build/tests 02:39:20 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')]} 02:39:20 INFO - trying https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.test_packages.json 02:39:20 INFO - Downloading https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:39:20 INFO - Downloaded 989 bytes. 02:39:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:39:20 INFO - Using the following test package requirements: 02:39:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:39:20 INFO - u'common': [u'target.common.tests.zip'], 02:39:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:39:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:39:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:39:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:39:20 INFO - u'mozbase': [u'target.common.tests.zip'], 02:39:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:39:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:39:20 INFO - u'web-platform': [u'target.common.tests.zip', 02:39:20 INFO - u'target.web-platform.tests.tar.gz'], 02:39:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:39:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:39:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.common.tests.zip 02:39:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:39:20 INFO - Fetch https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.common.tests.zip into memory 02:39:24 INFO - Content-Length response header: 55022366 02:39:24 INFO - Bytes received: 55022366 02:39:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:39:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.common.tests.zip 02:39:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:39:35 INFO - Fetch https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.common.tests.zip into memory 02:39:36 INFO - Content-Length response header: 55022366 02:39:36 INFO - Bytes received: 55022366 02:39:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.talos.tests.zip 02:39:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:39:49 INFO - Fetch https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.talos.tests.zip into memory 02:39:50 INFO - Content-Length response header: 14496650 02:39:50 INFO - Bytes received: 14496650 02:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:50 INFO - trying https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2 02:39:50 INFO - Downloading https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:39:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:39:51 INFO - Downloaded 62600457 bytes. 02:39:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2 02:39:51 INFO - mkdir: /builds/slave/test/properties 02:39:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:39:51 INFO - Writing to file /builds/slave/test/properties/build_url 02:39:51 INFO - Contents: 02:39:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2 02:39:51 INFO - Running post-action listener: _resource_record_post_action 02:39:51 INFO - Running post-action listener: find_tests_for_verification 02:39:51 INFO - Running post-action listener: set_extra_try_arguments 02:39:51 INFO - [mozharness: 2017-09-02 09:39:51.980404Z] Finished download-and-extract step (success) 02:39:51 INFO - [mozharness: 2017-09-02 09:39:51.980502Z] Running populate-webroot step. 02:39:51 INFO - Running pre-action listener: _resource_record_pre_action 02:39:51 INFO - Running main action method: populate_webroot 02:39:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:39:51 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:39:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:39:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:39:51 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:39:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:39:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:51 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:39:51 INFO - 'talos_options': ['--enable-stylo'], 02:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:39:51 INFO - 'tests': ['damp', 'tps']}, 02:39:51 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:39:51 INFO - 'talos_options': ['--enable-stylo'], 02:39:51 INFO - 'tests': ['damp', 'tps']}, 02:39:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:39:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:39:51 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:39:51 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:39:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:39:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:39:51 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:39:51 INFO - 'talos_options': ['--enable-stylo'], 02:39:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:39:51 INFO - 'other-e10s': {'tests': ['a11yr', 02:39:51 INFO - 'ts_paint', 02:39:51 INFO - 'tpaint', 02:39:51 INFO - 'sessionrestore', 02:39:51 INFO - 'sessionrestore_many_windows', 02:39:51 INFO - 'sessionrestore_no_auto_restore', 02:39:51 INFO - 'tabpaint']}, 02:39:51 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:39:51 INFO - 'tests': ['a11yr', 02:39:51 INFO - 'ts_paint', 02:39:51 INFO - 'tpaint', 02:39:51 INFO - 'sessionrestore', 02:39:51 INFO - 'sessionrestore_many_windows', 02:39:51 INFO - 'sessionrestore_no_auto_restore', 02:39:51 INFO - 'tabpaint']}, 02:39:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:39:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:39:51 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:39:51 INFO - 'tests': ['bloom_basic_singleton']}, 02:39:51 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:39:51 INFO - 'tests': ['bloom_basic']}, 02:39:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:39:51 INFO - 'tsvgr_opacity', 02:39:51 INFO - 'tart', 02:39:51 INFO - 'tscrollx', 02:39:51 INFO - 'tsvg_static']}, 02:39:51 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:39:51 INFO - 'tests': ['tsvgx', 02:39:51 INFO - 'tsvgr_opacity', 02:39:51 INFO - 'tart', 02:39:51 INFO - 'tscrollx', 02:39:51 INFO - 'tsvg_static']}, 02:39:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:39:51 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:39:51 INFO - 'talos_options': ['--enable-stylo'], 02:39:51 INFO - 'tests': ['tp5o']}, 02:39:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:39:51 INFO - 'talos_options': ['--mitmproxy', 02:39:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:39:51 INFO - '--firstNonBlankPaint'], 02:39:51 INFO - 'tests': ['tp6_google', 02:39:51 INFO - 'tp6_youtube', 02:39:51 INFO - 'tp6_amazon', 02:39:51 INFO - 'tp6_facebook']}, 02:39:51 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:39:51 INFO - 'talos_options': ['--enable-stylo', 02:39:51 INFO - '--mitmproxy', 02:39:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:39:51 INFO - '--firstNonBlankPaint'], 02:39:51 INFO - 'tests': ['tp6_google', 02:39:51 INFO - 'tp6_youtube', 02:39:51 INFO - 'tp6_amazon', 02:39:51 INFO - 'tp6_facebook']}, 02:39:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:39:51 INFO - 'talos_options': ['--enable-stylo', 02:39:51 INFO - '--stylo-threads=1', 02:39:51 INFO - '--mitmproxy', 02:39:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:39:51 INFO - '--firstNonBlankPaint'], 02:39:51 INFO - 'tests': ['tp6_google', 02:39:51 INFO - 'tp6_youtube', 02:39:51 INFO - 'tp6_amazon', 02:39:51 INFO - 'tp6_facebook']}, 02:39:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:39:51 INFO - 'talos_options': ['--xperf_path', 02:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:51 INFO - 'tests': ['tp5n']}, 02:39:51 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:39:51 INFO - 'talos_options': ['--enable-stylo', 02:39:51 INFO - '--xperf_path', 02:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:51 INFO - 'tests': ['tp5n']}}} 02:39:51 INFO - Running post-action listener: _resource_record_post_action 02:39:51 INFO - [mozharness: 2017-09-02 09:39:51.995315Z] Finished populate-webroot step (success) 02:39:51 INFO - [mozharness: 2017-09-02 09:39:51.995404Z] Running create-virtualenv step. 02:39:51 INFO - Running pre-action listener: _resource_record_pre_action 02:39:51 INFO - Running main action method: create_virtualenv 02:39:51 INFO - Creating virtualenv /builds/slave/test/build/venv 02:39:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:39:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:39:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:39:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:39:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:39:52 INFO - Installing distribute.............................................................................................................................................................................................done. 02:39:52 INFO - Installing pip...............done. 02:39:52 INFO - Return code: 0 02:39:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:39:52 INFO - Reading from file tmpfile_stdout 02:39:52 INFO - Output received: 02:39:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:39:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:39:52 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')]} 02:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:52 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')]} 02:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:52 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 0x159f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f090>, '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 0x190fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1909f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', '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 02:39:52 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 02:39:52 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 02:39:52 INFO - Using env: {'DISPLAY': ':0', 02:39:52 INFO - 'HOME': '/home/cltbld', 02:39:52 INFO - 'LANG': 'en_US.UTF-8', 02:39:52 INFO - 'LANGUAGE': 'en_US:en', 02:39:52 INFO - 'LOGNAME': 'cltbld', 02:39:52 INFO - 'MAIL': '/var/mail/cltbld', 02:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:52 INFO - 'MOZ_NO_REMOTE': '1', 02:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:52 INFO - 'NO_EM_RESTART': '1', 02:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:52 INFO - 'PWD': '/builds/slave/test', 02:39:52 INFO - 'SHELL': '/bin/bash', 02:39:52 INFO - 'SHLVL': '1', 02:39:52 INFO - 'TERM': 'linux', 02:39:52 INFO - 'TMOUT': '86400', 02:39:52 INFO - 'USER': 'cltbld', 02:39:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:52 INFO - '_': '/tools/buildbot/bin/python'} 02:39:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:39:54 INFO - Downloading/unpacking pip>=1.5 02:39:54 INFO - Running setup.py egg_info for package pip 02:39:54 INFO - warning: no files found matching 'pip/cacert.pem' 02:39:54 INFO - warning: no files found matching '*.html' under directory 'docs' 02:39:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:39:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:39:54 INFO - Installing collected packages: pip 02:39:54 INFO - Found existing installation: pip 1.1 02:39:54 INFO - Uninstalling pip: 02:39:54 INFO - Successfully uninstalled pip 02:39:54 INFO - Running setup.py install for pip 02:39:54 INFO - warning: no files found matching 'pip/cacert.pem' 02:39:54 INFO - warning: no files found matching '*.html' under directory 'docs' 02:39:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:39:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:39:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:39:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:39:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:39:54 INFO - Successfully installed pip 02:39:54 INFO - Cleaning up... 02:39:54 INFO - Return code: 0 02:39:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:54 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 0x159f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f090>, '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 0x190fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1909f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', '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 02:39:54 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 02:39:54 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 02:39:54 INFO - Using env: {'DISPLAY': ':0', 02:39:54 INFO - 'HOME': '/home/cltbld', 02:39:54 INFO - 'LANG': 'en_US.UTF-8', 02:39:54 INFO - 'LANGUAGE': 'en_US:en', 02:39:54 INFO - 'LOGNAME': 'cltbld', 02:39:54 INFO - 'MAIL': '/var/mail/cltbld', 02:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:54 INFO - 'MOZ_NO_REMOTE': '1', 02:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:54 INFO - 'NO_EM_RESTART': '1', 02:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:54 INFO - 'PWD': '/builds/slave/test', 02:39:54 INFO - 'SHELL': '/bin/bash', 02:39:54 INFO - 'SHLVL': '1', 02:39:54 INFO - 'TERM': 'linux', 02:39:54 INFO - 'TMOUT': '86400', 02:39:54 INFO - 'USER': 'cltbld', 02:39:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:54 INFO - '_': '/tools/buildbot/bin/python'} 02:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:54 INFO - Downloading/unpacking psutil>=3.1.1 02:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:39:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:55 INFO - Installing collected packages: psutil 02:39:55 INFO - Running setup.py install for psutil 02:39:55 INFO - building 'psutil._psutil_linux' extension 02:39:55 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 02:39:55 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 02:39:55 INFO - building 'psutil._psutil_posix' extension 02:39:55 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 02:39:56 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 02:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:56 INFO - Successfully installed psutil 02:39:56 INFO - Cleaning up... 02:39:56 INFO - Return code: 0 02:39:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:56 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 0x159f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f090>, '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 0x190fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1909f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', '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 02:39:56 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 02:39:56 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 02:39:56 INFO - Using env: {'DISPLAY': ':0', 02:39:56 INFO - 'HOME': '/home/cltbld', 02:39:56 INFO - 'LANG': 'en_US.UTF-8', 02:39:56 INFO - 'LANGUAGE': 'en_US:en', 02:39:56 INFO - 'LOGNAME': 'cltbld', 02:39:56 INFO - 'MAIL': '/var/mail/cltbld', 02:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:56 INFO - 'MOZ_NO_REMOTE': '1', 02:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:56 INFO - 'NO_EM_RESTART': '1', 02:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:56 INFO - 'PWD': '/builds/slave/test', 02:39:56 INFO - 'SHELL': '/bin/bash', 02:39:56 INFO - 'SHLVL': '1', 02:39:56 INFO - 'TERM': 'linux', 02:39:56 INFO - 'TMOUT': '86400', 02:39:56 INFO - 'USER': 'cltbld', 02:39:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:56 INFO - '_': '/tools/buildbot/bin/python'} 02:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:39:57 INFO - Installing collected packages: mozsystemmonitor 02:39:57 INFO - Running setup.py install for mozsystemmonitor 02:39:57 INFO - Successfully installed mozsystemmonitor 02:39:57 INFO - Cleaning up... 02:39:57 INFO - Return code: 0 02:39:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39: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')]} 02:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f090>, '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 0x190fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1909f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', '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 02:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:39:57 INFO - Using env: {'DISPLAY': ':0', 02:39:57 INFO - 'HOME': '/home/cltbld', 02:39:57 INFO - 'LANG': 'en_US.UTF-8', 02:39:57 INFO - 'LANGUAGE': 'en_US:en', 02:39:57 INFO - 'LOGNAME': 'cltbld', 02:39:57 INFO - 'MAIL': '/var/mail/cltbld', 02:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:57 INFO - 'MOZ_NO_REMOTE': '1', 02:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:57 INFO - 'NO_EM_RESTART': '1', 02:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:57 INFO - 'PWD': '/builds/slave/test', 02:39:57 INFO - 'SHELL': '/bin/bash', 02:39:57 INFO - 'SHLVL': '1', 02:39:57 INFO - 'TERM': 'linux', 02:39:57 INFO - 'TMOUT': '86400', 02:39:57 INFO - 'USER': 'cltbld', 02:39:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:57 INFO - '_': '/tools/buildbot/bin/python'} 02:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:57 INFO - Downloading/unpacking jsonschema==2.5.1 02:39: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 02:39: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 02:39: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 02:39: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 02:39:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:39:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:39: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 02:39: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 02:39: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 02:39: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 02:39:59 INFO - Downloading functools32-3.2.3-2.tar.gz 02:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:39:59 INFO - warning: no files found matching '*.txt' 02:39:59 INFO - no previously-included directories found matching 'build' 02:39:59 INFO - no previously-included directories found matching 'dist' 02:39:59 INFO - no previously-included directories found matching '.git*' 02:39:59 INFO - Installing collected packages: jsonschema, functools32 02:39:59 INFO - Running setup.py install for functools32 02:39:59 INFO - warning: no files found matching '*.txt' 02:39:59 INFO - no previously-included directories found matching 'build' 02:39:59 INFO - no previously-included directories found matching 'dist' 02:39:59 INFO - no previously-included directories found matching '.git*' 02:39:59 INFO - Successfully installed jsonschema functools32 02:39:59 INFO - Cleaning up... 02:39:59 INFO - Return code: 0 02:39:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:39:59 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')]} 02:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:59 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')]} 02:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:59 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 0x159f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f090>, '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 0x190fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1909f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', '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 02:39:59 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 02:39:59 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 02:39:59 INFO - Using env: {'DISPLAY': ':0', 02:39:59 INFO - 'HOME': '/home/cltbld', 02:39:59 INFO - 'LANG': 'en_US.UTF-8', 02:39:59 INFO - 'LANGUAGE': 'en_US:en', 02:39:59 INFO - 'LOGNAME': 'cltbld', 02:39:59 INFO - 'MAIL': '/var/mail/cltbld', 02:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:59 INFO - 'MOZ_NO_REMOTE': '1', 02:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:59 INFO - 'NO_EM_RESTART': '1', 02:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:59 INFO - 'PWD': '/builds/slave/test', 02:39:59 INFO - 'SHELL': '/bin/bash', 02:39:59 INFO - 'SHLVL': '1', 02:39:59 INFO - 'TERM': 'linux', 02:39:59 INFO - 'TMOUT': '86400', 02:39:59 INFO - 'USER': 'cltbld', 02:39:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:59 INFO - '_': '/tools/buildbot/bin/python'} 02:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:39:59 INFO - Cleaning up... 02:39:59 INFO - Return code: 0 02:39:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:39:59 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')]} 02:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:59 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')]} 02:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:59 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 0x159f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f090>, '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 0x190fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1909f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', '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 02:39:59 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 02:39:59 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 02:39:59 INFO - Using env: {'DISPLAY': ':0', 02:39:59 INFO - 'HOME': '/home/cltbld', 02:39:59 INFO - 'LANG': 'en_US.UTF-8', 02:39:59 INFO - 'LANGUAGE': 'en_US:en', 02:39:59 INFO - 'LOGNAME': 'cltbld', 02:39:59 INFO - 'MAIL': '/var/mail/cltbld', 02:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:59 INFO - 'MOZ_NO_REMOTE': '1', 02:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:59 INFO - 'NO_EM_RESTART': '1', 02:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:59 INFO - 'PWD': '/builds/slave/test', 02:39:59 INFO - 'SHELL': '/bin/bash', 02:39:59 INFO - 'SHLVL': '1', 02:39:59 INFO - 'TERM': 'linux', 02:39:59 INFO - 'TMOUT': '86400', 02:39:59 INFO - 'USER': 'cltbld', 02:39:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:59 INFO - '_': '/tools/buildbot/bin/python'} 02:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:59 INFO - Downloading/unpacking blobuploader==1.2.4 02:39: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 02:39: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 02:39: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 02:39: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 02:40:00 INFO - Downloading blobuploader-1.2.4.tar.gz 02:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:40:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:40:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:40:01 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 02:40:01 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 02:40:01 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 02:40:01 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 02:40:01 INFO - Downloading docopt-0.6.1.tar.gz 02:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:40:01 INFO - Installing collected packages: blobuploader, requests, docopt 02:40:01 INFO - Running setup.py install for blobuploader 02:40:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:40:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:40:01 INFO - Running setup.py install for requests 02:40:01 INFO - Running setup.py install for docopt 02:40:01 INFO - Successfully installed blobuploader requests docopt 02:40:01 INFO - Cleaning up... 02:40:02 INFO - Return code: 0 02:40:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:02 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 0x159f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f090>, '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 0x190fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1909f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', '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 02:40:02 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 02:40:02 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 02:40:02 INFO - Using env: {'DISPLAY': ':0', 02:40:02 INFO - 'HOME': '/home/cltbld', 02:40:02 INFO - 'LANG': 'en_US.UTF-8', 02:40:02 INFO - 'LANGUAGE': 'en_US:en', 02:40:02 INFO - 'LOGNAME': 'cltbld', 02:40:02 INFO - 'MAIL': '/var/mail/cltbld', 02:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:02 INFO - 'MOZ_NO_REMOTE': '1', 02:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:02 INFO - 'NO_EM_RESTART': '1', 02:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:02 INFO - 'PWD': '/builds/slave/test', 02:40:02 INFO - 'SHELL': '/bin/bash', 02:40:02 INFO - 'SHLVL': '1', 02:40:02 INFO - 'TERM': 'linux', 02:40:02 INFO - 'TMOUT': '86400', 02:40:02 INFO - 'USER': 'cltbld', 02:40:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:02 INFO - '_': '/tools/buildbot/bin/python'} 02:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:02 INFO - Running setup.py (path:/tmp/pip-uHw8wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:02 INFO - Running setup.py (path:/tmp/pip-_MnYm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:02 INFO - Running setup.py (path:/tmp/pip-ErD5cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:02 INFO - Running setup.py (path:/tmp/pip-tSIJdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:02 INFO - Running setup.py (path:/tmp/pip-_9Ssit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:02 INFO - Running setup.py (path:/tmp/pip-3KSdbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:02 INFO - Running setup.py (path:/tmp/pip-dX2ZEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:02 INFO - Running setup.py (path:/tmp/pip-eCwdOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:02 INFO - Running setup.py (path:/tmp/pip-o14xJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:02 INFO - Running setup.py (path:/tmp/pip-6nfEI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:02 INFO - Running setup.py (path:/tmp/pip-GoaAG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:03 INFO - Running setup.py (path:/tmp/pip-cPHsnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:03 INFO - Running setup.py (path:/tmp/pip-9OndP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:03 INFO - Running setup.py (path:/tmp/pip-ayGoNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:03 INFO - Running setup.py (path:/tmp/pip-vja6Ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:03 INFO - Running setup.py (path:/tmp/pip-pIX8ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:03 INFO - Running setup.py (path:/tmp/pip-zdgkUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:40:03 INFO - Running setup.py install for manifestparser 02:40:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:40:03 INFO - Running setup.py install for mozcrash 02:40:03 INFO - Running setup.py install for mozdebug 02:40:03 INFO - Running setup.py install for mozdevice 02:40:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:40:03 INFO - Running setup.py install for mozfile 02:40:03 INFO - Running setup.py install for mozhttpd 02:40:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Running setup.py install for mozinfo 02:40:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Running setup.py install for mozInstall 02:40:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Running setup.py install for mozleak 02:40:04 INFO - Running setup.py install for mozlog 02:40:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Running setup.py install for moznetwork 02:40:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Running setup.py install for mozprocess 02:40:04 INFO - Running setup.py install for mozprofile 02:40:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Running setup.py install for mozrunner 02:40:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:40:04 INFO - Running setup.py install for mozscreenshot 02:40:04 INFO - Running setup.py install for moztest 02:40:05 INFO - Running setup.py install for mozversion 02:40:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:40:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:40:05 INFO - Cleaning up... 02:40:05 INFO - Return code: 0 02:40:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:05 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')]} 02:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:05 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')]} 02:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:05 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 0x159f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f090>, '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 0x190fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1909f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', '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 02:40:05 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 02:40:05 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 02:40:05 INFO - Using env: {'DISPLAY': ':0', 02:40:05 INFO - 'HOME': '/home/cltbld', 02:40:05 INFO - 'LANG': 'en_US.UTF-8', 02:40:05 INFO - 'LANGUAGE': 'en_US:en', 02:40:05 INFO - 'LOGNAME': 'cltbld', 02:40:05 INFO - 'MAIL': '/var/mail/cltbld', 02:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:05 INFO - 'MOZ_NO_REMOTE': '1', 02:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:05 INFO - 'NO_EM_RESTART': '1', 02:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:05 INFO - 'PWD': '/builds/slave/test', 02:40:05 INFO - 'SHELL': '/bin/bash', 02:40:05 INFO - 'SHLVL': '1', 02:40:05 INFO - 'TERM': 'linux', 02:40:05 INFO - 'TMOUT': '86400', 02:40:05 INFO - 'USER': 'cltbld', 02:40:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:05 INFO - '_': '/tools/buildbot/bin/python'} 02:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:05 INFO - Running setup.py (path:/tmp/pip-Q_TvED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:05 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)) 02:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:05 INFO - Running setup.py (path:/tmp/pip-Qs2iKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40:05 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)) 02:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:05 INFO - Running setup.py (path:/tmp/pip-VAgN2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:05 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)) 02:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:05 INFO - Running setup.py (path:/tmp/pip-DUIQNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:05 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)) 02:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:05 INFO - Running setup.py (path:/tmp/pip-RJNKZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:05 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)) 02:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:05 INFO - Running setup.py (path:/tmp/pip-9H75N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:05 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)) 02:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:05 INFO - Running setup.py (path:/tmp/pip-Y5LRh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:05 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)) 02:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:05 INFO - Running setup.py (path:/tmp/pip-SWZdDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:05 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)) 02:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:05 INFO - Running setup.py (path:/tmp/pip-bC3hhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:06 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)) 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:06 INFO - Running setup.py (path:/tmp/pip-pVOBrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:06 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)) 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:06 INFO - Running setup.py (path:/tmp/pip-pSwyGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:06 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)) 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:06 INFO - Running setup.py (path:/tmp/pip-qHpHb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:06 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)) 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:06 INFO - Running setup.py (path:/tmp/pip-8LlIe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:06 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)) 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:06 INFO - Running setup.py (path:/tmp/pip-Uk4GTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:06 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)) 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:06 INFO - Running setup.py (path:/tmp/pip-ceUj7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:06 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)) 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:06 INFO - Running setup.py (path:/tmp/pip-75q9R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:06 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)) 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:06 INFO - Running setup.py (path:/tmp/pip-KUTK5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:06 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)) 02:40:06 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)) 02:40:06 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)) 02:40:06 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)) 02:40:06 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)) 02:40:06 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)) 02:40:06 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)) 02:40:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:40: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 02:40: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 02:40: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 02:40: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 02:40:07 INFO - Downloading blessings-1.6.tar.gz 02:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:40:07 INFO - Installing collected packages: blessings 02:40:07 INFO - Running setup.py install for blessings 02:40:07 INFO - Successfully installed blessings 02:40:07 INFO - Cleaning up... 02:40:07 INFO - Return code: 0 02:40:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:40:08 INFO - Reading from file tmpfile_stdout 02:40:08 INFO - Current package versions: 02:40:08 INFO - argparse == 1.2.1 02:40:08 INFO - blessings == 1.6 02:40:08 INFO - blobuploader == 1.2.4 02:40:08 INFO - docopt == 0.6.1 02:40:08 INFO - functools32 == 3.2.3-2 02:40:08 INFO - jsonschema == 2.5.1 02:40:08 INFO - manifestparser == 1.1 02:40:08 INFO - mozInstall == 1.13 02:40:08 INFO - mozcrash == 1.0 02:40:08 INFO - mozdebug == 0.1 02:40:08 INFO - mozdevice == 0.51 02:40:08 INFO - mozfile == 1.2 02:40:08 INFO - mozhttpd == 0.7 02:40:08 INFO - mozinfo == 0.10 02:40:08 INFO - mozleak == 0.1 02:40:08 INFO - mozlog == 3.5 02:40:08 INFO - moznetwork == 0.27 02:40:08 INFO - mozprocess == 0.25 02:40:08 INFO - mozprofile == 0.28 02:40:08 INFO - mozrunner == 6.13 02:40:08 INFO - mozscreenshot == 0.1 02:40:08 INFO - mozsystemmonitor == 0.3 02:40:08 INFO - moztest == 0.8 02:40:08 INFO - mozversion == 1.4 02:40:08 INFO - psutil == 3.1.1 02:40:08 INFO - requests == 1.2.3 02:40:08 INFO - wsgiref == 0.1.2 02:40:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:08 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')]} 02:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:08 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')]} 02:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:08 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 0x159f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f090>, '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 0x190fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1909f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', '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 02:40:08 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 02:40:08 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 02:40:08 INFO - Using env: {'DISPLAY': ':0', 02:40:08 INFO - 'HOME': '/home/cltbld', 02:40:08 INFO - 'LANG': 'en_US.UTF-8', 02:40:08 INFO - 'LANGUAGE': 'en_US:en', 02:40:08 INFO - 'LOGNAME': 'cltbld', 02:40:08 INFO - 'MAIL': '/var/mail/cltbld', 02:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:08 INFO - 'MOZ_NO_REMOTE': '1', 02:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:08 INFO - 'NO_EM_RESTART': '1', 02:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:08 INFO - 'PWD': '/builds/slave/test', 02:40:08 INFO - 'SHELL': '/bin/bash', 02:40:08 INFO - 'SHLVL': '1', 02:40:08 INFO - 'TERM': 'linux', 02:40:08 INFO - 'TMOUT': '86400', 02:40:08 INFO - 'USER': 'cltbld', 02:40:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:08 INFO - '_': '/tools/buildbot/bin/python'} 02:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:08 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)) 02:40:08 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)) 02:40:08 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)) 02:40:08 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)) 02:40:08 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)) 02:40:08 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)) 02:40:08 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)) 02:40:08 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)) 02:40:08 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)) 02:40:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:40:08 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 02:40:08 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 02:40:08 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 02:40:08 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 02:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:40:09 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)) 02:40:09 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)) 02:40:09 INFO - Installing collected packages: simplejson 02:40:09 INFO - Running setup.py install for simplejson 02:40:09 INFO - building 'simplejson._speedups' extension 02:40:09 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 02:40:10 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 02:40:10 INFO - Successfully installed simplejson 02:40:10 INFO - Cleaning up... 02:40:10 INFO - Return code: 0 02:40:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:10 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 0x159f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f090>, '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 0x190fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1909f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', '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 02:40:10 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 02:40:10 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 02:40:10 INFO - Using env: {'DISPLAY': ':0', 02:40:10 INFO - 'HOME': '/home/cltbld', 02:40:10 INFO - 'LANG': 'en_US.UTF-8', 02:40:10 INFO - 'LANGUAGE': 'en_US:en', 02:40:10 INFO - 'LOGNAME': 'cltbld', 02:40:10 INFO - 'MAIL': '/var/mail/cltbld', 02:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:10 INFO - 'MOZ_NO_REMOTE': '1', 02:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:10 INFO - 'NO_EM_RESTART': '1', 02:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:10 INFO - 'PWD': '/builds/slave/test', 02:40:10 INFO - 'SHELL': '/bin/bash', 02:40:10 INFO - 'SHLVL': '1', 02:40:10 INFO - 'TERM': 'linux', 02:40:10 INFO - 'TMOUT': '86400', 02:40:10 INFO - 'USER': 'cltbld', 02:40:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:10 INFO - '_': '/tools/buildbot/bin/python'} 02:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:40:10 INFO - Cleaning up... 02:40:10 INFO - Return code: 0 02:40:10 INFO - Running post-action listener: _resource_record_post_action 02:40:10 INFO - Running post-action listener: _start_resource_monitoring 02:40:10 INFO - Starting resource monitoring. 02:40:10 INFO - [mozharness: 2017-09-02 09:40:10.886454Z] Finished create-virtualenv step (success) 02:40:10 INFO - [mozharness: 2017-09-02 09:40:10.886959Z] Running install step. 02:40:10 INFO - Running pre-action listener: _resource_record_pre_action 02:40:10 INFO - Running main action method: install 02:40:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:40:11 INFO - Reading from file tmpfile_stdout 02:40:11 INFO - Detecting whether we're running mozinstall >=1.0... 02:40:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:40:11 INFO - Reading from file tmpfile_stdout 02:40:11 INFO - Output received: 02:40:11 INFO - Usage: mozinstall [options] installer 02:40:11 INFO - Options: 02:40:11 INFO - -h, --help show this help message and exit 02:40:11 INFO - -d DEST, --destination=DEST 02:40:11 INFO - Directory to install application into. [default: 02:40:11 INFO - "/builds/slave/test"] 02:40:11 INFO - --app=APP Application being installed. [default: firefox] 02:40:11 INFO - mkdir: /builds/slave/test/build/application 02:40:11 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'] 02:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:40:27 INFO - Reading from file tmpfile_stdout 02:40:27 INFO - Output received: 02:40:27 INFO - /builds/slave/test/build/application/firefox/firefox 02:40:27 INFO - Running post-action listener: _resource_record_post_action 02:40:27 INFO - [mozharness: 2017-09-02 09:40:27.723272Z] Finished install step (success) 02:40:27 INFO - [mozharness: 2017-09-02 09:40:27.723519Z] Running setup-mitmproxy step. 02:40:27 INFO - Running pre-action listener: _resource_record_pre_action 02:40:27 INFO - Running main action method: setup_mitmproxy 02:40:27 INFO - Skipping: mitmproxy is not required 02:40:27 INFO - Running post-action listener: _resource_record_post_action 02:40:27 INFO - [mozharness: 2017-09-02 09:40:27.724623Z] Finished setup-mitmproxy step (success) 02:40:27 INFO - [mozharness: 2017-09-02 09:40:27.724840Z] Running run-tests step. 02:40:27 INFO - Running pre-action listener: _resource_record_pre_action 02:40:27 INFO - Running pre-action listener: _set_gcov_prefix 02:40:27 INFO - Running main action method: run_tests 02:40:27 WARNING - Try message not found. 02:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:40:27 INFO - Python 2.7.3 02:40:27 INFO - Return code: 0 02:40:27 INFO - grabbing minidump binary from tooltool 02:40: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')]} 02:40: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 0x190f090>, '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 0x190fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1909f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:40: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 02:40: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 02:40: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 02:40:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:40:27 INFO - Return code: 0 02:40:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:40:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:40:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:40:27 INFO - ENV: RUST_BACKTRACE is now full 02:40:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:40:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:40: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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:40: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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:40:27 INFO - Using env: {'DISPLAY': ':0', 02:40:27 INFO - 'HOME': '/home/cltbld', 02:40:27 INFO - 'LANG': 'en_US.UTF-8', 02:40:27 INFO - 'LANGUAGE': 'en_US:en', 02:40:27 INFO - 'LOGNAME': 'cltbld', 02:40:27 INFO - 'MAIL': '/var/mail/cltbld', 02:40:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:40:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:27 INFO - 'MOZ_NO_REMOTE': '1', 02:40:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:27 INFO - 'NO_EM_RESTART': '1', 02:40:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:27 INFO - 'PWD': '/builds/slave/test', 02:40:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:40:27 INFO - 'RUST_BACKTRACE': 'full', 02:40:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:40:27 INFO - 'SHELL': '/bin/bash', 02:40:27 INFO - 'SHLVL': '1', 02:40:27 INFO - 'STYLO_FORCE_ENABLED': '1', 02:40:27 INFO - 'STYLO_THREADS': '1', 02:40:27 INFO - 'TERM': 'linux', 02:40:27 INFO - 'TMOUT': '86400', 02:40:27 INFO - 'USER': 'cltbld', 02:40:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:27 INFO - '_': '/tools/buildbot/bin/python'} 02:40:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:40:28 INFO - mozversion application_buildid: 20170902085228 02:40:28 INFO - mozversion application_changeset: b01a7e57425b5fe791ab091f5c33e069890753fb 02:40:28 INFO - mozversion application_display_name: Nightly 02:40:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:40:28 INFO - mozversion application_name: Firefox 02:40:28 INFO - mozversion application_remotingname: firefox 02:40:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:40:28 INFO - mozversion application_vendor: Mozilla 02:40:28 INFO - mozversion application_version: 57.0a1 02:40:28 INFO - mozversion platform_buildid: 20170902085228 02:40:28 INFO - mozversion platform_changeset: b01a7e57425b5fe791ab091f5c33e069890753fb 02:40:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:40:28 INFO - mozversion platform_version: 57.0a1 02:40:28 INFO - using testdate: 1504345228 02:40:28 INFO - actual date: 1504345228 02:40:28 INFO - starting webserver on 'localhost:54937' 02:40:28 INFO - SUITE-START | Running 2 tests 02:40:28 INFO - TEST-START | dromaeo_css 02:40:28 INFO - Initialising browser for dromaeo_css test... 02:40:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54937/getInfo.html -profile /tmp/tmplwZhvz/profile 02:40:28 INFO - TEST-INFO | started process 13695 (/builds/slave/test/build/application/firefox/firefox http://localhost:54937/getInfo.html) 02:40:34 INFO - TEST-INFO | 13695: exit 0 02:40:34 INFO - Browser initialized. 02:40:34 INFO - Running cycle 1/1 for dromaeo_css test... 02:40:34 INFO - Using env: {'DISPLAY': ':0', 02:40:34 INFO - 'HOME': '/home/cltbld', 02:40:34 INFO - 'JSGC_DISABLE_POISONING': '1', 02:40:34 INFO - 'LANG': 'en_US.UTF-8', 02:40:34 INFO - 'LANGUAGE': 'en_US:en', 02:40:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:40:34 INFO - 'LOGNAME': 'cltbld', 02:40:34 INFO - 'MAIL': '/var/mail/cltbld', 02:40:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:40:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:40:34 INFO - 'MOZ_CRASHREPORTER': '1', 02:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:40:34 INFO - 'MOZ_NO_REMOTE': '1', 02:40:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:34 INFO - 'NO_EM_RESTART': '1', 02:40:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:34 INFO - 'PWD': '/builds/slave/test', 02:40:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:40:34 INFO - 'RUST_BACKTRACE': 'full', 02:40:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:40:34 INFO - 'SHELL': '/bin/bash', 02:40:34 INFO - 'SHLVL': '1', 02:40:34 INFO - 'STYLO_FORCE_ENABLED': '1', 02:40:34 INFO - 'STYLO_THREADS': '1', 02:40:34 INFO - 'TERM': 'linux', 02:40:34 INFO - 'TMOUT': '86400', 02:40:34 INFO - 'USER': 'cltbld', 02:40:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:34 INFO - '_': '/tools/buildbot/bin/python'} 02:40:34 INFO - TEST-INFO | started process 13881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplwZhvz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:35 INFO - PID 13881 | 02:40:35 INFO - PID 13881 | (/builds/slave/test/build/application/firefox/firefox:13932): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:40:35 INFO - PID 13881 | 02:40:45 INFO - PID 13881 | RSS: Main: 170283008 02:40:45 INFO - PID 13881 | 02:43:44 INFO - PID 13881 | Cycle 1(1): loaded http://localhost:54937/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54937/tests/dromaeo/cssquery-ext.html) 02:43:45 INFO - PID 13881 | RSS: Main: 173023232 02:43:45 INFO - PID 13881 | 02:46:47 INFO - PID 13881 | Cycle 1(1): loaded http://localhost:54937/tests/dromaeo/cssquery-ext.html (next: http://localhost:54937/tests/dromaeo/cssquery-jquery.html) 02:46:48 INFO - PID 13881 | RSS: Main: 170459136 02:46:48 INFO - PID 13881 | 02:49:50 INFO - PID 13881 | Cycle 1(1): loaded http://localhost:54937/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54937/tests/dromaeo/cssquery-mootools.html) 02:49:50 INFO - PID 13881 | RSS: Main: 173006848 02:49:50 INFO - PID 13881 | 02:52:52 INFO - PID 13881 | Cycle 1(1): loaded http://localhost:54937/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54937/tests/dromaeo/cssquery-prototype.html) 02:52:53 INFO - PID 13881 | RSS: Main: 171429888 02:52:53 INFO - PID 13881 | 02:55:56 INFO - PID 13881 | Cycle 1(1): loaded http://localhost:54937/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54937/tests/dromaeo/cssquery-yui.html) 02:55:57 INFO - PID 13881 | RSS: Main: 172511232 02:55:57 INFO - PID 13881 | 02:58:58 INFO - PID 13881 | Cycle 1(1): loaded http://localhost:54937/tests/dromaeo/cssquery-yui.html (next: http://localhost:54937/tests/dromaeo/cssquery-dojo.html) 02:58:59 INFO - PID 13881 | RSS: Main: 173539328 02:58:59 INFO - PID 13881 | 02:58:59 INFO - PID 13881 | __start_tp_report 02:58:59 INFO - PID 13881 | _x_x_mozilla_page_load 02:58:59 INFO - PID 13881 | _x_x_mozilla_page_load_details 02:58:59 INFO - PID 13881 | |i|pagename|runs| 02:58:59 INFO - PID 13881 | |0;dojo.html;3339.1985923378397;3343.515190297406;3346.096553930439;3382.3404436134933;3386.153461634591;6386.808395748135;6428.807135785923;6448.54860159789;6484.675766211694;6493;6270.65511396873;6370.362963703627;6385.457236134934;6400.807975760723;6402.551821372505;5805.15825205346;5942.078977758454;5944.524438044968;5953.940460595382;6064.302605200414;5801.245838041049;5909.468147866691;5923.763049478037;6014.578979471439;6063.363346848583;5883.17635531026;5900.586958912878;5901.881962360751;5928.466438020599;5935.347111817697;5879.79420720277;5897.469227769521;5955.672438015908;5975.820725378246;5979.491743201833;5851;5861.941380586182;5867.559933005042;5909.734061967221;5945.851353716192;6416.197975253093;6430.871382572323;6453.451456626145;6487.740490380379;6490.740370385179;6857.657117144123;6858.485613578951;6860.0738900248325;6968.860622787566;6975.162980442379;6828.829279268009;6949.652517374162;6953.721851125949;6969.0940177776565;7042.471814613873;6432.292447830781;6437;6442.613443193377;6443.581167224115;6459.709313080875;6985.545939513915;7016.298370162943;7091.3972312353;7092.219855815856;7143.357097861218;6720.563163394364;6809.250982391933;6825.317468253135;6826.795196144024;6840.247572766992;6895;6919.792406227822;6931.861362772716;6974.511784175161;6976.093107895941;6682.298358672367;6768.830779230559;6802.251752307242;6809.0467334573195;6901.62041087735;6925.896111558331;6973.825654358681;6974.546654467444;7000.579965202104;7004.649767511604;5416.864578385493;5486.670799752028;5488.286522752017;5492.093804522289;5494.450554944474;4720.315554244684;4746.95253047472;4764.523547645277;4794.5924596409695;4809.495003024632;5881.676507792113;5960.284765828128;5967.433093856077;5970.402959704082;6067.544934129958;6879.415249703731;6905.1713794345;6955.408790252784;6960.65196740161;6974.616396098263;5972.522198224132;6012.939870601325;6025.035994240988;6063.151158837766;6065.2418447694035;5901.645901245939;5912.290525137011;5981.641101533922;5994.28068631767;6005.069214271794;6564.704588293538;6599.241087275025;6699.5310328276555;6772.8984065239065;6775.119234499483;6804.693788779417;6874.450043996569;6876.587404755731;6882.449404047564;6882.793516194522;6596.241432235354;6630.038644396632;6701.564398314094;6716.932830671826;6717.832054198489;6745.426638735762;6821.386075253251;6830.3852653259455;6859.759908403182;6866.416354609914;6904.827379315558;6919.965400172967;6926;6998.6150761708595;7005.614691192033;6538.901916471162;6563.671816409256;6637.70130344126;6640.837853375543;6671.666416679243;6566.24488183865;6618;6637.137172167587;6644.003399489922;6665.700043498151;5994.730237139426;6491.675416229265;6521.478281737544;6630.336966303331;6639.601623902388;6619.205695316593;6623.138991931018;6755.729770809309;6806.081179040766;6815.114035175396;6279.748810047547;6368.108464815023;6461.0954466373805;6550.672466376567;6554.442872355903 02:58:59 INFO - PID 13881 | |1;ext.html;767.5663250263601;812.4800127918134;838.9496630202186;1123.1688550472643;1147.9827802582959;37092.07269818256;41019.17961640765;41116.38325425121;41128;41222.58777412225;41035.38446923299;41216.175676486455;41225.175496490054;41262.793686031604;41520;7449.739259125945;7648.617569121549;7662.501937374081;7664.501807382502;7672.271134242266;7555.433342499307;7666.7316643917475;7667.42494312926;7671.347935425468;7674.501157424777;7653.693852245903;7713.691452341927;7715.035620547432;7715.305622493975;7716.575588342639;7648.655810488513;7683.270089341504;7687.0391201099865;7689.577073260968;7692.961535192316;7475.252474752536;7532.548047117136;7533.02070730807;7536.208698086677;7539.811504712371;36884.63115368839;37195.442068369;37221.81389093064;37222;37288.06779830499;3483.9129021774406;3517.876874309387;3531.382008148589;3532.6643968822923;3533.1697051193205;30529.847350763324;30603.387932241454;30662;30677.84661076703;30772.53841192384;5145.974270128663;5155.046316431472;5162.561182299509;5211.270422140903;5211.348581427322;185935;186138;187487;187817;188394.05802971034;46374.5362546377;46551.5344846554;46600.5339946603;46624.300635490494;46671.76664116658;50576.24135637969;51410.74294628503;51511.48488515067;51687.48312516902;51717.2242416364;14228;14509;15223.923880380527;15361.462348817739;15948;13157.473701051851;13282;13298.401571929286;13319.40062697181;13320;13995.930020350037;14084.85915140856;14171.716565668836;14180.078294910798;14233.28833558318;5875.853103672443;5935.614185077956;5971.28344598651;5973.074173503114;5985.760569577255;988.5699720621552;1006.3408467453684;1015.7308313296983;1015.898410158993;1027.429776474049;22842.543149136924;22856.173710910898;22991.54016919686;23220.3033908983;23267.53464930692;1092.088106431123;1093.5571093706903;1097.5884043483693;1098.5605757696985;1109.4009235013002;12140.392980350947;15724.13517256539;15861.603459913364;15868.285927133307;16239;231074;232436;232705;233192;233214;54843;55067;55239.72380138074;55268.72365638146;55292.44707552953;1410.1961881727316;1416.8795652369663;1432.4055516960345;1438.0508864149401;1441.452248145698;27513.406492822065;27596.172114836587;27714.861425692743;27971.300717482227;28021;37898.810505947295;38365.80817095897;38378.42432363461;38404.615953840104;38421.423678644285;201115;202147;203060;204672;205885;33623.15942101467;36386.45420318644;37936.81031594824;37957;38132.80933595314;45269.54730452653;45595;45668.314975276066;45738;46239.30641040454;33761.66238337585;33968.83015585005;34041.31917361688;34074.488882667276;34228.315433691685;34169;34421.139471513416;34451.65548344485;34452.48321275233;34864.65135348614;38470.42294365531;38530.422043668805;38581.807090964365;38856.80571597237;38917.416238755875;33653.83173084217;33829.66170338265;33922.32155356929;33936.490952635235;33946.32107357888;24270.51458970846;24332.270031899072;24966;25349.366265843502;25561.360965976 02:58:59 INFO - PID 13881 | |2;jquery.html;563.6871536297353;564.9802256921006;568.1534513574775;573.1774903014174;583.2621733507115;21898.23356182532;22283.55432891345;22603.660945085838;22618.660720089192;22689.09243630253;24903.252902412958;25392.365190870238;25474.36314092144;25533.234002979894;25553.488930221432;6538.444232240254;6682.766103186389;6685.699143538553;6701.195856497203;6703.631300278483;5873.970630146843;6473.029045643168;6474.0612611171355;6477.028445733131;6482.611043337415;6438.549301548894;6446.452051575622;6450.2259728832605;6452.838679033038;6456.58032227906;6446.967765161167;6453.128827608283;6453.612783233021;6453.83865403364;6462.063000864871;5910.822675319747;5993.580449368546;5999.040153575407;6003;6010.879782404328;27955.720442795515;28497.57253641197;28943.276418089506;29146.562801557993;29172;2016.798320167986;2048.9180432782673;2049.6515592349338;2050.2209160519055;2054.7739748627637;18419.44741657739;19337.903310483358;19355.612887742165;19369.03154842252;19439.12523936426;2352.235523454867;2376.809855211596;2404.7955923746504;2425.757424257578;2464.2853572463964;129429;131831;132285.3385733065;132304;132361;14482.637934051732;14541;14608.34262458192;14663.706725865422;15034.699306014038;22597.09611615517;22739.886300568392;22759.772402276096;22760.20339288117;22826.42933926665;9196.632134714537;9373.671921482852;9410.811783764286;9486.525673716425;9489.525523723787;7795.14253432122;8118.553479558563;8517.74446766598;8542.974843018754;8597.5701214939;8888.73333799987;9154.496502692282;9176.403533770284;9244.214241789523;9335.159835614828;2583.083005533046;2638.129417292327;2701.5812549054535;2735.193118030186;2764.9308767280977;949.8480243161199;964.324000897515;981.1464026297025;991.0881988570533;991.7173605522536;19151.616967660568;19577.216911323674;19646.21415143378;20122.094505747278;23571.29286121419;999.0867488758945;1073.0664322039875;1073.951672174754;1075.2473268711776;1078.196743426137;10930.180236482296;11203.943980280046;11302.37836918961;13384;13832.993971333828;482647;484989;486969;491216;504041;122359.38820305842;123168.38415808043;123502;125985;126337.36831315784;1228.81567764836;1251.9123661343801;1262.5139321361341;1271.9809202861964;1283.5828355784408;21030.894845525676;21230.150793968067;21374.465638359165;21652.35042948714;21774.237901673365;54469.72765136149;54495.72752136214;55381;56356.43643563676;56488.43511564832;67995;68138.65930670315;68649.65675171593;69349.65325173341;69397.30602693908;14075.577732668036;14360;14402.927985360006;14428.639284017983;14431.134131952116;20785.168593256705;20798.27206047781;20829.791702082784;22221.888890555445;23283.301500955;16813.579660508585;16964.066976316422;16970.236339365005;17046.147692615566;17080.316787328367;14948.327325270606;16035.518934431986;16294.103824289778;16999.98000119997;17015.489535313962;17725;18062.187201575696;18679.626407471504;18684.34604788826;18711.625767484846;13753.656158596115;14158.50445234412;14472.276386180438;14515.709685806436;14560.927195364378;18550.165242564388;18660.81339186645;18787.530311741768;18950;18974.525636859187 02:58:59 INFO - PID 13881 | |3;mootools.html;1305.908586398952;1363.1275983370642;1363.2638375277352;1369.5069774881047;1370.609376327746;14784.926075369622;15436.845631543696;15440.69118617627;15450.768238476432;15468;14940.850591494082;15943.441979530719;15948.28232729527;15968;15986.360545578164;2753.7383948524857;2797.8041537092413;2798.4543014112255;2799.1322689966178;2799.4401119776126;2646.2325925481587;2654.774344180747;2726.754592086712;2727.1818454463682;2782.9443411131865;2595.467929074545;2596.948061038778;2616.1497513308154;2616.581346984483;2619.0833208377107;2708.268767432792;2715.4297597504547;2716.361655011071;2720.0751744407;2721.945561088777;2597.6493173421723;2623.6589243398425;2624.829386089898;2626.776723978464;2628.4217472156097;14725.926370368186;15054;15056.849431505654;15063.774043389358;15069.321880515294;8059.073206581201;8364.163583641588;8368.832623347498;8370.3303735701;8375.623096960651;5102.948970510284;5119.641625086246;5181.481851814789;5248.816291429782;5452.836414907559;1890.7447494588191;1905.7141428785656;1920.596674698315;1969.222157247879;1970.8916009619466;26244;26683.466330673276;26744.465110697678;26798.464030719275;26822;6679.465642748569;6695.765648202289;6733.764318248838;6851.794446166623;6875.209350924708;17044.829551704574;17087.401940932257;17092.91453542749;17106.828931710774;17132.40036598738;7878.960605196938;8053.1141574426765;8058.838823223503;8063.233992770677;8066.959665201636;7237.927620723831;7426.183119856812;7472.962635186789;7485.850282994418;7491.213422590658;5242.659227150223;5379.67721936685;5412.783488660488;5459.590530710213;5501.037318469332;1470.4118352659023;1493.0742939377656;1503.150719843285;1551.95344139676;1554.7434673279008;887.6138879587401;903.4985583001497;904.7964208053266;914.7758799094264;919.5632074764567;8224.712135075364;8286.088530261666;8304.252617264476;8332.208440198172;8380.580970951429;1001.8597396364515;1003.4932359158578;1006.441425009127;1009.1573536097294;1024.7284469615558;5106.259592359162;5125.359330083739;5268.525832675001;5280.603954703336;5593.356763972195;20731;21586.35240942774;21721.131154753948;21910.23314183996;21940.561188776453;20704.171833126806;21091.261805836722;21492.892535537223;21792.455188620093;21920.561588768134;10796.67609971702;10907.618233361953;10923.563057477772;10992.780144397228;11049.613263535737;8304.83390332202;8348.666053357798;8506.702265420929;8527.573621319034;8598.871016934625;18602.534936626693;18803.811961880205;19087.618247635248;19343.51641208981;19486.077088436847;18907.90546047316;19050.714239286146;19103.235870565022;19107.522311942314;19167.808321916604;11080.39057851826;11326.716832079264;11329.773404532029;11336.433178341214;11341.149413793833;13931.930340348234;13945;14014.719705605627;14072;14117.08238964464;10625.840612390666;10643.627473038407;10727.19546034035;10810.729731756768;10966.342019478856;11019.228653994463;11074.833877492005;11086.722831929266;11136.276142050741;11371.43142842871;8997.64009439615;9082.545872706207;9091.363604547618;9092.727218183465;9098.863517047383;6876.724931002904;6878.071460352789;6899.965500172467;6938.098047253825;6939.167299924042;6943.791686249218;7009.12385951756;7022.754203602849;7037.7184912602925;7126.536775109601 02:58:59 INFO - PID 13881 | |4;prototype.html;505.3077284120755;515.4999650339171;537.3846945247692;538.4588488568988;540.1573545269378;6378.712957916893;6409.038644203371;6449.129367535381;6492.545521813469;6496.7401303947845;6102.420270074336;6152.784652537162;6184.350643182469;6241.157443745093;6297.370262973712;4977.456988333628;5054.368203974504;5074.314967479399;5079.746012699368;5098.311727916721;4908.410990681105;5012.874678133057;5015.699058056528;5067.290579318898;5080.161773307418;4977.303177555145;5045.470225626312;5051.898962020758;5065.721385323805;5096.974515127419;5030.874228144307;5055.696658200502;5077.847664570068;5086.720230387327;5093.643444958854;4534.251848445003;4558.544145585448;4559.019810740707;4561.589456948891;4569.405977222973;6222.751089956441;6245.437910588023;6249.187605611241;6316;6327.335629758901;5823.708814559297;5849.122631605251;5862;5877.853053673693;5883.558733094992;6592.868142637169;6650.93349066508;6658.400743933069;6672.899906501407;6745.3254674532645;4920.114379411704;4939.3578834751615;4950.0842344166085;4953.455119936804;4984.526469985346;7071.257517960592;7074;7104.11198600175;7132.179799323092;7151.427885769126;5077.517635824591;5085.440601533828;5089.236614507853;5133.589312854962;5143.099957507421;5148.819791307286;5164.535191832753;5184.585233181337;5187.377514698185;5210.166373380317;5814.215080964016;5830.970845145747;5831.446012628793;5842.38654941225;5852.561057920673;6697.7655782047395;6705.463562914955;6722.865542689119;6740.932590674129;6759.580488097555;1689.9577510562087;1721.1480317243045;1724.7240441529295;1758.7361895715744;1776.7601373814628;1216.3431746856597;1220.7741567809983;1245.5702782540009;1247.819066235391;1253.9498420063096;5812.534997200214;5823.82528524145;5827.3007239131575;5851.882962340729;5870.941290587125;6764.661766911635;6771.3905748482875;6775.816500377216;6777.966110169417;6911.861762764716;5888.439563515672;5901;5901.370657045886;5904.822855314347;5930.762769489258;3612.765170263977;3623.4927110204594;3635.2911182319194;3639.217568222845;3674.5039419678;6705.228898676617;6710.328967103348;6722.378272473739;6723.562968407038;6724.7646332378135;7053.964730176316;7118;7166.784996450115;7166.856662866818;7202.459815513753;6709.563878347989;6734.966325168343;6739.191297044288;6745.831354216184;6760.797176084824;6911.5853048817235;6919.930800691928;6927.856903611049;6979.40675042627;7024.6136462493005;6849.554778939353;6868.450523957971;6868.484863635347;6871.347222013901;6874.4844136690945;6615.338466153538;6655.402703351064;6751.45988320943;6757.614688988844;6781.93218067813;5072.82245121419;5086.923696144635;5090.516400941905;5093.18509038552;5097.11406779494;6660.766873159416;6926.307369263235;6963.825904352431;6964.721411143498;7010.509264351446;6486.740530378732;6495.675216239075;6552.770653027312;6579.967100164468;6612.537122401386;6518.545171059346;6535.411812936859;6636.767713130017;6697;6722.731090756511;6537.477001839937;6582.313904213655;6604.24051234095;6622.37087476689;6673.89880669684;6701.497387695845;6712.9664351679885;6731.966340168267;6732.037903322523;6761.290064543152;6472.152253008661;6500.154979852589;6549.657320249433;6593.109930159559;6594.406503414716 02:58:59 INFO - PID 13881 | |5;yui.html;884.7036242858642;885.0574138542448;896.7130518234168;910.3127139010046;913.4473643445713;18680.4395868124;19635.410937671855;19654.21383144676;19703.901480492594;19907.900460497676;19946.70079948802;19949.900250498762;20123.19507219713;20124.396268111945;20129.899350503263;964.5273815830245;977.4086677560081;984.4388698441891;987.0228473810947;987.5901500877127;980.0542476510167;981.9361741486816;984.0110688757788;984.099548912744;985.1133979418508;989.6387818446251;1019.3628981886321;1027.9434631095287;1030.5774632400717;1030.953607087679;1018.9082982531571;1022.2435397805644;1022.2844009193594;1024.0987930621043;1024.2830018986701;753.2016062973266;754.3098065270326;754.4417131322837;754.852803703278;755.0599503618031;17850.821491785046;18653;19810.70283945742;20138.295159669487;20246.291379801783;20654.58690826175;20657.793422065737;21178.470538236514;21194.470138246514;21218.151273949024;16068.839311606967;16337.754933675886;16518.83481165185;16647.750283745754;16660.916695416447;3667.7615954963107;3686.041629176407;3693.519842420468;3696.149885526344;3696.3900956342172;124993.37503312516;129527.35236323759;129762;130806.3459682705;132098.3395083028;16018.439354622533;16447.91776041112;16463;16497.83502164987;16522.50432487027;30407.847960760053;30489.08532744021;30557.388852223277;30690;30817.2295692605;7439.107307123179;7648.08223013242;7772.533647981139;7923.722669706648;8615.095414981462;4199.601037901394;4316.827326906951;4317.633001194871;4317.654587633045;4319.913601727948;5293.338332708411;5406.243125962368;5424.321959755031;5441.129419292894;5460.972695136499;1058.6347710040025;1076.7469644633504;1077.0468135699805;1080.3517889266534;1090.6019302954523;668.9331066893271;683.1938312790954;697.4873468001015;704.4012589299157;706.7349743846057;12003.399830008464;12047;12249.142560020713;12509.624711258677;12895;663.2008429842028;678.2064983968768;681.5399605266425;681.9386255236954;688.8243497908102;5674.943250567524;5733.655980641175;5773.566982476331;5842.737076831553;6020.69896505173;108219.45890270655;108247.45876270568;108472.45763771131;109543;110763.44618277019;94626.52686736522;96507;99773;102529.48735256276;102551;86126;86752.56623716967;88950;90525.54737226272;90976.54511727398;12654.367281636065;12907.096503244682;12935;13003.284819334649;13014.80477792815;40942.590574093876;41259.7937010313;41691.1661766769;42017.57982420259;43366.783166083966;51212;51330.48669513257;52940.73529632327;53464.46535534595;55244.171337429165;16281.674366512367;16360.918195408947;16369.42707005249;16713.247903844112;16789.580260493585;20961.161553537688;20970.685439718112;20981;21081.6837747437;21170.04734786969;19269.22923083061;19357;19370.2251909922;19433.222671092997;19520.31678891232;18432;18869.90565047166;18949.526261843563;18969.33607323737;19102.808971910657;16406.17969101564;16502.75245871289;16536.421225257538;16681.499555013368;16776.07731574726;13852.722945541234;14144.929275353557;14225.502107426191;14365.712685746017;14435.855641443872;12939.676508087374;13432.731345372842;13464.865351346753;13489.258090804708;13608.183508989096 02:58:59 INFO - PID 13881 | __end_tp_report 02:58:59 INFO - PID 13881 | __start_cc_report 02:58:59 INFO - PID 13881 | _x_x_mozilla_cycle_collect,381 02:58:59 INFO - PID 13881 | __end_cc_report 02:58:59 INFO - PID 13881 | __startTimestamp1504346339237__endTimestamp 02:58:59 INFO - PID 13881 | 02:58:59 INFO - PID 13881 | ------- Summary: start ------- 02:58:59 INFO - PID 13881 | Number of tests: 6 02:58:59 INFO - PID 13881 | 02:58:59 INFO - PID 13881 | [#0] dojo.html Cycles:165 Average:6336.69 Median:6550.67 stddev:735.15 (11.2%) stddev-sans-first:698.79 02:58:59 INFO - PID 13881 | Values: 3339.2 3343.5 3346.1 3382.3 3386.2 6386.8 6428.8 6448.5 6484.7 6493.0 6270.7 6370.4 6385.5 6400.8 6402.6 5805.2 5942.1 5944.5 5953.9 6064.3 5801.2 5909.5 5923.8 6014.6 6063.4 5883.2 5900.6 5901.9 5928.5 5935.3 5879.8 5897.5 5955.7 5975.8 5979.5 5851.0 5861.9 5867.6 5909.7 5945.9 6416.2 6430.9 6453.5 6487.7 6490.7 6857.7 6858.5 6860.1 6968.9 6975.2 6828.8 6949.7 6953.7 6969.1 7042.5 6432.3 6437.0 6442.6 6443.6 6459.7 6985.5 7016.3 7091.4 7092.2 7143.4 6720.6 6809.3 6825.3 6826.8 6840.2 6895.0 6919.8 6931.9 6974.5 6976.1 6682.3 6768.8 6802.3 6809.0 6901.6 6925.9 6973.8 6974.5 7000.6 7004.6 5416.9 5486.7 5488.3 5492.1 5494.5 4720.3 4747.0 4764.5 4794.6 4809.5 5881.7 5960.3 5967.4 5970.4 6067.5 6879.4 6905.2 6955.4 6960.7 6974.6 5972.5 6012.9 6025.0 6063.2 6065.2 5901.6 5912.3 5981.6 5994.3 6005.1 6564.7 6599.2 6699.5 6772.9 6775.1 6804.7 6874.5 6876.6 6882.4 6882.8 6596.2 6630.0 6701.6 6716.9 6717.8 6745.4 6821.4 6830.4 6859.8 6866.4 6904.8 6920.0 6926.0 6998.6 7005.6 6538.9 6563.7 6637.7 6640.8 6671.7 6566.2 6618.0 6637.1 6644.0 6665.7 5994.7 6491.7 6521.5 6630.3 6639.6 6619.2 6623.1 6755.7 6806.1 6815.1 6279.7 6368.1 6461.1 6550.7 6554.4 02:58:59 INFO - PID 13881 | 02:58:59 INFO - PID 13881 | [#1] ext.html Cycles:180 Average:38276.59 Median:3532.92 stddev:53961.63 (1527.4%) stddev-sans-first:54039.50 02:58:59 INFO - PID 13881 | Values: 767.6 812.5 838.9 1123.2 1148.0 37092.1 41019.2 41116.4 41128.0 41222.6 41035.4 41216.2 41225.2 41262.8 41520.0 7449.7 7648.6 7662.5 7664.5 7672.3 7555.4 7666.7 7667.4 7671.3 7674.5 7653.7 7713.7 7715.0 7715.3 7716.6 7648.7 7683.3 7687.0 7689.6 7693.0 7475.3 7532.5 7533.0 7536.2 7539.8 36884.6 37195.4 37221.8 37222.0 37288.1 3483.9 3517.9 3531.4 3532.7 3533.2 30529.8 30603.4 30662.0 30677.8 30772.5 5146.0 5155.0 5162.6 5211.3 5211.3 185935.0 186138.0 187487.0 187817.0 188394.1 46374.5 46551.5 46600.5 46624.3 46671.8 50576.2 51410.7 51511.5 51687.5 51717.2 14228.0 14509.0 15223.9 15361.5 15948.0 13157.5 13282.0 13298.4 13319.4 13320.0 13995.9 14084.9 14171.7 14180.1 14233.3 5875.9 5935.6 5971.3 5973.1 5985.8 988.6 1006.3 1015.7 1015.9 1027.4 22842.5 22856.2 22991.5 23220.3 23267.5 1092.1 1093.6 1097.6 1098.6 1109.4 12140.4 15724.1 15861.6 15868.3 16239.0 231074.0 232436.0 232705.0 233192.0 233214.0 54843.0 55067.0 55239.7 55268.7 55292.4 1410.2 1416.9 1432.4 1438.1 1441.5 27513.4 27596.2 27714.9 27971.3 28021.0 37898.8 38365.8 38378.4 38404.6 38421.4 201115.0 202147.0 203060.0 204672.0 205885.0 33623.2 36386.5 37936.8 37957.0 38132.8 45269.5 45595.0 45668.3 45738.0 46239.3 33761.7 33968.8 34041.3 34074.5 34228.3 34169.0 34421.1 34451.7 34452.5 34864.7 38470.4 38530.4 38581.8 38856.8 38917.4 33653.8 33829.7 33922.3 33936.5 33946.3 24270.5 24332.3 24966.0 25349.4 25561.4 02:58:59 INFO - PID 13881 | 02:58:59 INFO - PID 13881 | [#2] jquery.html Cycles:180 Average:34652.28 Median:22793.32 stddev:82584.04 (362.3%) stddev-sans-first:82776.05 02:58:59 INFO - PID 13881 | Values: 563.7 565.0 568.2 573.2 583.3 21898.2 22283.6 22603.7 22618.7 22689.1 24903.3 25392.4 25474.4 25533.2 25553.5 6538.4 6682.8 6685.7 6701.2 6703.6 5874.0 6473.0 6474.1 6477.0 6482.6 6438.5 6446.5 6450.2 6452.8 6456.6 6447.0 6453.1 6453.6 6453.8 6462.1 5910.8 5993.6 5999.0 6003.0 6010.9 27955.7 28497.6 28943.3 29146.6 29172.0 2016.8 2048.9 2049.7 2050.2 2054.8 18419.4 19337.9 19355.6 19369.0 19439.1 2352.2 2376.8 2404.8 2425.8 2464.3 129429.0 131831.0 132285.3 132304.0 132361.0 14482.6 14541.0 14608.3 14663.7 15034.7 22597.1 22739.9 22759.8 22760.2 22826.4 9196.6 9373.7 9410.8 9486.5 9489.5 7795.1 8118.6 8517.7 8543.0 8597.6 8888.7 9154.5 9176.4 9244.2 9335.2 2583.1 2638.1 2701.6 2735.2 2764.9 949.8 964.3 981.1 991.1 991.7 19151.6 19577.2 19646.2 20122.1 23571.3 999.1 1073.1 1074.0 1075.2 1078.2 10930.2 11203.9 11302.4 13384.0 13833.0 482647.0 484989.0 486969.0 491216.0 504041.0 122359.4 123168.4 123502.0 125985.0 126337.4 1228.8 1251.9 1262.5 1272.0 1283.6 21030.9 21230.2 21374.5 21652.4 21774.2 54469.7 54495.7 55381.0 56356.4 56488.4 67995.0 68138.7 68649.7 69349.7 69397.3 14075.6 14360.0 14402.9 14428.6 14431.1 20785.2 20798.3 20829.8 22221.9 23283.3 16813.6 16964.1 16970.2 17046.1 17080.3 14948.3 16035.5 16294.1 17000.0 17015.5 17725.0 18062.2 18679.6 18684.3 18711.6 13753.7 14158.5 14472.3 14515.7 14560.9 18550.2 18660.8 18787.5 18950.0 18974.5 02:58:59 INFO - PID 13881 | 02:58:59 INFO - PID 13881 | [#3] mootools.html Cycles:180 Average:9316.67 Median:2621.37 stddev:6694.97 (255.4%) stddev-sans-first:6686.70 02:58:59 INFO - PID 13881 | Values: 1305.9 1363.1 1363.3 1369.5 1370.6 14784.9 15436.8 15440.7 15450.8 15468.0 14940.9 15943.4 15948.3 15968.0 15986.4 2753.7 2797.8 2798.5 2799.1 2799.4 2646.2 2654.8 2726.8 2727.2 2782.9 2595.5 2596.9 2616.1 2616.6 2619.1 2708.3 2715.4 2716.4 2720.1 2721.9 2597.6 2623.7 2624.8 2626.8 2628.4 14725.9 15054.0 15056.8 15063.8 15069.3 8059.1 8364.2 8368.8 8370.3 8375.6 5102.9 5119.6 5181.5 5248.8 5452.8 1890.7 1905.7 1920.6 1969.2 1970.9 26244.0 26683.5 26744.5 26798.5 26822.0 6679.5 6695.8 6733.8 6851.8 6875.2 17044.8 17087.4 17092.9 17106.8 17132.4 7879.0 8053.1 8058.8 8063.2 8067.0 7237.9 7426.2 7473.0 7485.9 7491.2 5242.7 5379.7 5412.8 5459.6 5501.0 1470.4 1493.1 1503.2 1552.0 1554.7 887.6 903.5 904.8 914.8 919.6 8224.7 8286.1 8304.3 8332.2 8380.6 1001.9 1003.5 1006.4 1009.2 1024.7 5106.3 5125.4 5268.5 5280.6 5593.4 20731.0 21586.4 21721.1 21910.2 21940.6 20704.2 21091.3 21492.9 21792.5 21920.6 10796.7 10907.6 10923.6 10992.8 11049.6 8304.8 8348.7 8506.7 8527.6 8598.9 18602.5 18803.8 19087.6 19343.5 19486.1 18907.9 19050.7 19103.2 19107.5 19167.8 11080.4 11326.7 11329.8 11336.4 11341.1 13931.9 13945.0 14014.7 14072.0 14117.1 10625.8 10643.6 10727.2 10810.7 10966.3 11019.2 11074.8 11086.7 11136.3 11371.4 8997.6 9082.5 9091.4 9092.7 9098.9 6876.7 6878.1 6900.0 6938.1 6939.2 6943.8 7009.1 7022.8 7037.7 7126.5 02:58:59 INFO - PID 13881 | 02:58:59 INFO - PID 13881 | [#4] prototype.html Cycles:180 Average:5636.82 Median:6247.31 stddev:1596.99 (25.6%) stddev-sans-first:1554.33 02:58:59 INFO - PID 13881 | Values: 505.3 515.5 537.4 538.5 540.2 6378.7 6409.0 6449.1 6492.5 6496.7 6102.4 6152.8 6184.4 6241.2 6297.4 4977.5 5054.4 5074.3 5079.7 5098.3 4908.4 5012.9 5015.7 5067.3 5080.2 4977.3 5045.5 5051.9 5065.7 5097.0 5030.9 5055.7 5077.8 5086.7 5093.6 4534.3 4558.5 4559.0 4561.6 4569.4 6222.8 6245.4 6249.2 6316.0 6327.3 5823.7 5849.1 5862.0 5877.9 5883.6 6592.9 6650.9 6658.4 6672.9 6745.3 4920.1 4939.4 4950.1 4953.5 4984.5 7071.3 7074.0 7104.1 7132.2 7151.4 5077.5 5085.4 5089.2 5133.6 5143.1 5148.8 5164.5 5184.6 5187.4 5210.2 5814.2 5831.0 5831.4 5842.4 5852.6 6697.8 6705.5 6722.9 6740.9 6759.6 1690.0 1721.1 1724.7 1758.7 1776.8 1216.3 1220.8 1245.6 1247.8 1253.9 5812.5 5823.8 5827.3 5851.9 5870.9 6764.7 6771.4 6775.8 6778.0 6911.9 5888.4 5901.0 5901.4 5904.8 5930.8 3612.8 3623.5 3635.3 3639.2 3674.5 6705.2 6710.3 6722.4 6723.6 6724.8 7054.0 7118.0 7166.8 7166.9 7202.5 6709.6 6735.0 6739.2 6745.8 6760.8 6911.6 6919.9 6927.9 6979.4 7024.6 6849.6 6868.5 6868.5 6871.3 6874.5 6615.3 6655.4 6751.5 6757.6 6781.9 5072.8 5086.9 5090.5 5093.2 5097.1 6660.8 6926.3 6963.8 6964.7 7010.5 6486.7 6495.7 6552.8 6580.0 6612.5 6518.5 6535.4 6636.8 6697.0 6722.7 6537.5 6582.3 6604.2 6622.4 6673.9 6701.5 6713.0 6732.0 6732.0 6761.3 6472.2 6500.2 6549.7 6593.1 6594.4 02:58:59 INFO - PID 13881 | 02:58:59 INFO - PID 13881 | [#5] yui.html Cycles:180 Average:23465.37 Median:20450.44 stddev:32040.69 (156.7%) stddev-sans-first:32085.71 02:58:59 INFO - PID 13881 | Values: 884.7 885.1 896.7 910.3 913.4 18680.4 19635.4 19654.2 19703.9 19907.9 19946.7 19949.9 20123.2 20124.4 20129.9 964.5 977.4 984.4 987.0 987.6 980.1 981.9 984.0 984.1 985.1 989.6 1019.4 1027.9 1030.6 1031.0 1018.9 1022.2 1022.3 1024.1 1024.3 753.2 754.3 754.4 754.9 755.1 17850.8 18653.0 19810.7 20138.3 20246.3 20654.6 20657.8 21178.5 21194.5 21218.2 16068.8 16337.8 16518.8 16647.8 16660.9 3667.8 3686.0 3693.5 3696.1 3696.4 124993.4 129527.4 129762.0 130806.3 132098.3 16018.4 16447.9 16463.0 16497.8 16522.5 30407.8 30489.1 30557.4 30690.0 30817.2 7439.1 7648.1 7772.5 7923.7 8615.1 4199.6 4316.8 4317.6 4317.7 4319.9 5293.3 5406.2 5424.3 5441.1 5461.0 1058.6 1076.7 1077.0 1080.4 1090.6 668.9 683.2 697.5 704.4 706.7 12003.4 12047.0 12249.1 12509.6 12895.0 663.2 678.2 681.5 681.9 688.8 5674.9 5733.7 5773.6 5842.7 6020.7 108219.5 108247.5 108472.5 109543.0 110763.4 94626.5 96507.0 99773.0 102529.5 102551.0 86126.0 86752.6 88950.0 90525.5 90976.5 12654.4 12907.1 12935.0 13003.3 13014.8 40942.6 41259.8 41691.2 42017.6 43366.8 51212.0 51330.5 52940.7 53464.5 55244.2 16281.7 16360.9 16369.4 16713.2 16789.6 20961.2 20970.7 20981.0 21081.7 21170.0 19269.2 19357.0 19370.2 19433.2 19520.3 18432.0 18869.9 18949.5 18969.3 19102.8 16406.2 16502.8 16536.4 16681.5 16776.1 13852.7 14144.9 14225.5 14365.7 14435.9 12939.7 13432.7 13464.9 13489.3 13608.2 02:58:59 INFO - PID 13881 | -------- Summary: end -------- 02:58:59 INFO - PID 13881 | 02:58:59 INFO - TEST-INFO | 13881: exit 0 02:58:59 INFO - TEST-OK | dromaeo_css | took 1111888ms 02:58:59 INFO - TEST-START | kraken 02:58:59 INFO - Initialising browser for kraken test... 02:58:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54937/getInfo.html -profile /tmp/tmpVRCLP3/profile 02:58:59 INFO - TEST-INFO | started process 14251 (/builds/slave/test/build/application/firefox/firefox http://localhost:54937/getInfo.html) 02:59:06 INFO - TEST-INFO | 14251: exit 0 02:59:06 INFO - Browser initialized. 02:59:06 INFO - Running cycle 1/1 for kraken test... 02:59:06 INFO - Using env: {'DISPLAY': ':0', 02:59:06 INFO - 'HOME': '/home/cltbld', 02:59:06 INFO - 'JSGC_DISABLE_POISONING': '1', 02:59:06 INFO - 'LANG': 'en_US.UTF-8', 02:59:06 INFO - 'LANGUAGE': 'en_US:en', 02:59:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:59:06 INFO - 'LOGNAME': 'cltbld', 02:59:06 INFO - 'MAIL': '/var/mail/cltbld', 02:59:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:59:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:59:06 INFO - 'MOZ_CRASHREPORTER': '1', 02:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:59:06 INFO - 'MOZ_NO_REMOTE': '1', 02:59:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:06 INFO - 'NO_EM_RESTART': '1', 02:59:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:06 INFO - 'PWD': '/builds/slave/test', 02:59:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:59:06 INFO - 'RUST_BACKTRACE': 'full', 02:59:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:59:06 INFO - 'SHELL': '/bin/bash', 02:59:06 INFO - 'SHLVL': '1', 02:59:06 INFO - 'STYLO_FORCE_ENABLED': '1', 02:59:06 INFO - 'STYLO_THREADS': '1', 02:59:06 INFO - 'TERM': 'linux', 02:59:06 INFO - 'TMOUT': '86400', 02:59:06 INFO - 'USER': 'cltbld', 02:59:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073', 02:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:06 INFO - '_': '/tools/buildbot/bin/python'} 02:59:06 INFO - TEST-INFO | started process 14438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVRCLP3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:59:07 INFO - PID 14438 | 02:59:07 INFO - PID 14438 | (/builds/slave/test/build/application/firefox/firefox:14489): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:59:07 INFO - PID 14438 | 02:59:17 INFO - PID 14438 | RSS: Main: 167399424 02:59:17 INFO - PID 14438 | 02:59:20 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54937/tests/kraken/driver.html?testName=audio-beat-detection) 02:59:21 INFO - PID 14438 | RSS: Main: 173248512 02:59:21 INFO - PID 14438 | 02:59:23 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54937/tests/kraken/driver.html?testName=audio-dft) 02:59:24 INFO - PID 14438 | RSS: Main: 173584384 02:59:24 INFO - PID 14438 | 02:59:27 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54937/tests/kraken/driver.html?testName=audio-fft) 02:59:28 INFO - PID 14438 | RSS: Main: 166969344 02:59:28 INFO - PID 14438 | 02:59:30 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54937/tests/kraken/driver.html?testName=audio-oscillator) 02:59:30 INFO - PID 14438 | RSS: Main: 167915520 02:59:30 INFO - PID 14438 | 02:59:32 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54937/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:59:33 INFO - PID 14438 | RSS: Main: 168079360 02:59:33 INFO - PID 14438 | 02:59:36 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54937/tests/kraken/driver.html?testName=imaging-darkroom) 02:59:37 INFO - PID 14438 | RSS: Main: 170569728 02:59:37 INFO - PID 14438 | 02:59:40 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54937/tests/kraken/driver.html?testName=imaging-desaturate) 02:59:41 INFO - PID 14438 | RSS: Main: 170377216 02:59:41 INFO - PID 14438 | 02:59:44 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54937/tests/kraken/driver.html?testName=json-parse-financial) 02:59:44 INFO - PID 14438 | RSS: Main: 170688512 02:59:44 INFO - PID 14438 | 02:59:46 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54937/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:59:47 INFO - PID 14438 | RSS: Main: 170586112 02:59:47 INFO - PID 14438 | 02:59:48 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54937/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:59:49 INFO - PID 14438 | RSS: Main: 170561536 02:59:49 INFO - PID 14438 | 02:59:51 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54937/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:59:52 INFO - PID 14438 | RSS: Main: 170979328 02:59:52 INFO - PID 14438 | 02:59:54 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:59:55 INFO - PID 14438 | RSS: Main: 171139072 02:59:55 INFO - PID 14438 | 02:59:58 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:59 INFO - PID 14438 | RSS: Main: 171118592 02:59:59 INFO - PID 14438 | 03:00:00 INFO - PID 14438 | Cycle 1(1): loaded http://localhost:54937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54937/tests/kraken/driver.html?testName=ai-astar) 03:00:01 INFO - PID 14438 | RSS: Main: 172908544 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | __start_tp_report 03:00:01 INFO - PID 14438 | _x_x_mozilla_page_load 03:00:01 INFO - PID 14438 | _x_x_mozilla_page_load_details 03:00:01 INFO - PID 14438 | |i|pagename|runs| 03:00:01 INFO - PID 14438 | |0;ai-astar;98;107;100;108;107;113;108;98;108;109 03:00:01 INFO - PID 14438 | |1;audio-beat-detection;154;116;147;180;119;149;151;117;165;119 03:00:01 INFO - PID 14438 | |2;audio-dft;164;164;164;162;163;162;164;167;168;161 03:00:01 INFO - PID 14438 | |3;audio-fft;74;74;74;171;75;74;74;74;160;75 03:00:01 INFO - PID 14438 | |4;audio-oscillator;79;81;127;81;80;79;130;80;80;122 03:00:01 INFO - PID 14438 | |5;imaging-gaussian-blur;114;114;114;114;113;113;114;114;114;114 03:00:01 INFO - PID 14438 | |6;imaging-darkroom;149;147;148;148;147;147;149;147;149;148 03:00:01 INFO - PID 14438 | |7;imaging-desaturate;94;94;93;94;94;94;93;93;94;94 03:00:01 INFO - PID 14438 | |8;json-parse-financial;52;54;51;52;52;53;52;51;53;53 03:00:01 INFO - PID 14438 | |9;json-stringify-tinderbox;38;37;38;38;38;38;38;39;38;38 03:00:01 INFO - PID 14438 | |10;stanford-crypto-aes;76;75;78;75;75;76;79;73;74;79 03:00:01 INFO - PID 14438 | |11;stanford-crypto-ccm;118;122;115;119;120;132;123;144;117;159 03:00:01 INFO - PID 14438 | |12;stanford-crypto-pbkdf2;172;173;179;173;177;170;170;173;171;167 03:00:01 INFO - PID 14438 | |13;stanford-crypto-sha256-iterative;66;69;66;65;70;65;76;65;71;64 03:00:01 INFO - PID 14438 | __end_tp_report 03:00:01 INFO - PID 14438 | __start_cc_report 03:00:01 INFO - PID 14438 | _x_x_mozilla_cycle_collect,935 03:00:01 INFO - PID 14438 | __end_cc_report 03:00:01 INFO - PID 14438 | __startTimestamp1504346401196__endTimestamp 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | ------- Summary: start ------- 03:00:01 INFO - PID 14438 | Number of tests: 14 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#0] ai-astar Cycles:10 Average:105.60 Median:108.50 stddev:5.10 (4.7%) stddev-sans-first:4.61 03:00:01 INFO - PID 14438 | Values: 98.0 107.0 100.0 108.0 107.0 113.0 108.0 98.0 108.0 109.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:150.00 stddev:22.68 (15.1%) stddev-sans-first:23.62 03:00:01 INFO - PID 14438 | Values: 154.0 116.0 147.0 180.0 119.0 149.0 151.0 117.0 165.0 119.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.18 (1.3%) stddev-sans-first:2.32 03:00:01 INFO - PID 14438 | Values: 164.0 164.0 164.0 162.0 163.0 162.0 164.0 167.0 168.0 161.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#3] audio-fft Cycles:10 Average:92.50 Median:74.00 stddev:38.56 (52.1%) stddev-sans-first:40.32 03:00:01 INFO - PID 14438 | Values: 74.0 74.0 74.0 171.0 75.0 74.0 74.0 74.0 160.0 75.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:80.00 stddev:22.47 (28.1%) stddev-sans-first:23.18 03:00:01 INFO - PID 14438 | Values: 79.0 81.0 127.0 81.0 80.0 79.0 130.0 80.0 80.0 122.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:00:01 INFO - PID 14438 | Values: 114.0 114.0 114.0 114.0 113.0 113.0 114.0 114.0 114.0 114.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 03:00:01 INFO - PID 14438 | Values: 149.0 147.0 148.0 148.0 147.0 147.0 149.0 147.0 149.0 148.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:00:01 INFO - PID 14438 | Values: 94.0 94.0 93.0 94.0 94.0 94.0 93.0 93.0 94.0 94.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:0.95 (1.8%) stddev-sans-first:1.00 03:00:01 INFO - PID 14438 | Values: 52.0 54.0 51.0 52.0 52.0 53.0 52.0 51.0 53.0 53.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.47 (1.2%) stddev-sans-first:0.50 03:00:01 INFO - PID 14438 | Values: 38.0 37.0 38.0 38.0 38.0 38.0 38.0 39.0 38.0 38.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:2.05 (2.7%) stddev-sans-first:2.18 03:00:01 INFO - PID 14438 | Values: 76.0 75.0 78.0 75.0 75.0 76.0 79.0 73.0 74.0 79.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:122.50 stddev:14.21 (11.6%) stddev-sans-first:14.70 03:00:01 INFO - PID 14438 | Values: 118.0 122.0 115.0 119.0 120.0 132.0 123.0 144.0 117.0 159.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.00 stddev:3.47 (2.0%) stddev-sans-first:3.68 03:00:01 INFO - PID 14438 | Values: 172.0 173.0 179.0 173.0 177.0 170.0 170.0 173.0 171.0 167.0 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:3.77 (5.6%) stddev-sans-first:3.95 03:00:01 INFO - PID 14438 | Values: 66.0 69.0 66.0 65.0 70.0 65.0 76.0 65.0 71.0 64.0 03:00:01 INFO - PID 14438 | -------- Summary: end -------- 03:00:01 INFO - PID 14438 | 03:00:01 INFO - PID 14438 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:00:01 INFO - TEST-INFO | 14438: exit 0 03:00:01 INFO - TEST-OK | kraken | took 61927ms 03:00:01 INFO - SUITE-END | took 1173s 03:00:02 INFO - Completed test suite (00:19:34) 03:00:02 INFO - javascript benchmark 03:00:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8620.439683254697, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.1985923378397, 3343.515190297406, 3346.096553930439, 3382.3404436134933, 3386.153461634591, 6386.808395748135, 6428.807135785923, 6448.54860159789, 6484.675766211694, 6493.0, 6270.65511396873, 6370.362963703627, 6385.457236134934, 6400.807975760723, 6402.551821372505, 5805.15825205346, 5942.078977758454, 5944.524438044968, 5953.940460595382, 6064.302605200414, 5801.245838041049, 5909.468147866691, 5923.763049478037, 6014.578979471439, 6063.363346848583, 5883.17635531026, 5900.586958912878, 5901.881962360751, 5928.466438020599, 5935.347111817697, 5879.79420720277, 5897.469227769521, 5955.672438015908, 5975.820725378246, 5979.491743201833, 5851.0, 5861.941380586182, 5867.559933005042, 5909.734061967221, 5945.851353716192, 6416.197975253093, 6430.871382572323, 6453.451456626145, 6487.740490380379, 6490.740370385179, 6857.657117144123, 6858.485613578951, 6860.0738900248325, 6968.860622787566, 6975.162980442379, 6828.829279268009, 6949.652517374162, 6953.721851125949, 6969.0940177776565, 7042.471814613873, 6432.292447830781, 6437.0, 6442.613443193377, 6443.581167224115, 6459.709313080875, 6985.545939513915, 7016.298370162943, 7091.3972312353, 7092.219855815856, 7143.357097861218, 6720.563163394364, 6809.250982391933, 6825.317468253135, 6826.795196144024, 6840.247572766992, 6895.0, 6919.792406227822, 6931.861362772716, 6974.511784175161, 6976.093107895941, 6682.298358672367, 6768.830779230559, 6802.251752307242, 6809.0467334573195, 6901.62041087735, 6925.896111558331, 6973.825654358681, 6974.546654467444, 7000.579965202104, 7004.649767511604, 5416.864578385493, 5486.670799752028, 5488.286522752017, 5492.093804522289, 5494.450554944474, 4720.315554244684, 4746.95253047472, 4764.523547645277, 4794.5924596409695, 4809.495003024632, 5881.676507792113, 5960.284765828128, 5967.433093856077, 5970.402959704082, 6067.544934129958, 6879.415249703731, 6905.1713794345, 6955.408790252784, 6960.65196740161, 6974.616396098263, 5972.522198224132, 6012.939870601325, 6025.035994240988, 6063.151158837766, 6065.2418447694035, 5901.645901245939, 5912.290525137011, 5981.641101533922, 5994.28068631767, 6005.069214271794, 6564.704588293538, 6599.241087275025, 6699.5310328276555, 6772.8984065239065, 6775.119234499483, 6804.693788779417, 6874.450043996569, 6876.587404755731, 6882.449404047564, 6882.793516194522, 6596.241432235354, 6630.038644396632, 6701.564398314094, 6716.932830671826, 6717.832054198489, 6745.426638735762, 6821.386075253251, 6830.3852653259455, 6859.759908403182, 6866.416354609914, 6904.827379315558, 6919.965400172967, 6926.0, 6998.6150761708595, 7005.614691192033, 6538.901916471162, 6563.671816409256, 6637.70130344126, 6640.837853375543, 6671.666416679243, 6566.24488183865, 6618.0, 6637.137172167587, 6644.003399489922, 6665.700043498151, 5994.730237139426, 6491.675416229265, 6521.478281737544, 6630.336966303331, 6639.601623902388, 6619.205695316593, 6623.138991931018, 6755.729770809309, 6806.081179040766, 6815.114035175396, 6279.748810047547, 6368.108464815023, 6461.0954466373805, 6550.672466376567, 6554.442872355903], "value": 6283.5081959607205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.5663250263601, 812.4800127918134, 838.9496630202186, 1123.1688550472643, 1147.9827802582959, 37092.07269818256, 41019.17961640765, 41116.38325425121, 41128.0, 41222.58777412225, 41035.38446923299, 41216.175676486455, 41225.175496490054, 41262.793686031604, 41520.0, 7449.739259125945, 7648.617569121549, 7662.501937374081, 7664.501807382502, 7672.271134242266, 7555.433342499307, 7666.7316643917475, 7667.42494312926, 7671.347935425468, 7674.501157424777, 7653.693852245903, 7713.691452341927, 7715.035620547432, 7715.305622493975, 7716.575588342639, 7648.655810488513, 7683.270089341504, 7687.0391201099865, 7689.577073260968, 7692.961535192316, 7475.252474752536, 7532.548047117136, 7533.02070730807, 7536.208698086677, 7539.811504712371, 36884.63115368839, 37195.442068369, 37221.81389093064, 37222.0, 37288.06779830499, 3483.9129021774406, 3517.876874309387, 3531.382008148589, 3532.6643968822923, 3533.1697051193205, 30529.847350763324, 30603.387932241454, 30662.0, 30677.84661076703, 30772.53841192384, 5145.974270128663, 5155.046316431472, 5162.561182299509, 5211.270422140903, 5211.348581427322, 185935.0, 186138.0, 187487.0, 187817.0, 188394.05802971034, 46374.5362546377, 46551.5344846554, 46600.5339946603, 46624.300635490494, 46671.76664116658, 50576.24135637969, 51410.74294628503, 51511.48488515067, 51687.48312516902, 51717.2242416364, 14228.0, 14509.0, 15223.923880380527, 15361.462348817739, 15948.0, 13157.473701051851, 13282.0, 13298.401571929286, 13319.40062697181, 13320.0, 13995.930020350037, 14084.85915140856, 14171.716565668836, 14180.078294910798, 14233.28833558318, 5875.853103672443, 5935.614185077956, 5971.28344598651, 5973.074173503114, 5985.760569577255, 988.5699720621552, 1006.3408467453684, 1015.7308313296983, 1015.898410158993, 1027.429776474049, 22842.543149136924, 22856.173710910898, 22991.54016919686, 23220.3033908983, 23267.53464930692, 1092.088106431123, 1093.5571093706903, 1097.5884043483693, 1098.5605757696985, 1109.4009235013002, 12140.392980350947, 15724.13517256539, 15861.603459913364, 15868.285927133307, 16239.0, 231074.0, 232436.0, 232705.0, 233192.0, 233214.0, 54843.0, 55067.0, 55239.72380138074, 55268.72365638146, 55292.44707552953, 1410.1961881727316, 1416.8795652369663, 1432.4055516960345, 1438.0508864149401, 1441.452248145698, 27513.406492822065, 27596.172114836587, 27714.861425692743, 27971.300717482227, 28021.0, 37898.810505947295, 38365.80817095897, 38378.42432363461, 38404.615953840104, 38421.423678644285, 201115.0, 202147.0, 203060.0, 204672.0, 205885.0, 33623.15942101467, 36386.45420318644, 37936.81031594824, 37957.0, 38132.80933595314, 45269.54730452653, 45595.0, 45668.314975276066, 45738.0, 46239.30641040454, 33761.66238337585, 33968.83015585005, 34041.31917361688, 34074.488882667276, 34228.315433691685, 34169.0, 34421.139471513416, 34451.65548344485, 34452.48321275233, 34864.65135348614, 38470.42294365531, 38530.422043668805, 38581.807090964365, 38856.80571597237, 38917.416238755875, 33653.83173084217, 33829.66170338265, 33922.32155356929, 33936.490952635235, 33946.32107357888, 24270.51458970846, 24332.270031899072, 24966.0, 25349.366265843502, 25561.360965976], "value": 17552.80601415984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.6871536297353, 564.9802256921006, 568.1534513574775, 573.1774903014174, 583.2621733507115, 21898.23356182532, 22283.55432891345, 22603.660945085838, 22618.660720089192, 22689.09243630253, 24903.252902412958, 25392.365190870238, 25474.36314092144, 25533.234002979894, 25553.488930221432, 6538.444232240254, 6682.766103186389, 6685.699143538553, 6701.195856497203, 6703.631300278483, 5873.970630146843, 6473.029045643168, 6474.0612611171355, 6477.028445733131, 6482.611043337415, 6438.549301548894, 6446.452051575622, 6450.2259728832605, 6452.838679033038, 6456.58032227906, 6446.967765161167, 6453.128827608283, 6453.612783233021, 6453.83865403364, 6462.063000864871, 5910.822675319747, 5993.580449368546, 5999.040153575407, 6003.0, 6010.879782404328, 27955.720442795515, 28497.57253641197, 28943.276418089506, 29146.562801557993, 29172.0, 2016.798320167986, 2048.9180432782673, 2049.6515592349338, 2050.2209160519055, 2054.7739748627637, 18419.44741657739, 19337.903310483358, 19355.612887742165, 19369.03154842252, 19439.12523936426, 2352.235523454867, 2376.809855211596, 2404.7955923746504, 2425.757424257578, 2464.2853572463964, 129429.0, 131831.0, 132285.3385733065, 132304.0, 132361.0, 14482.637934051732, 14541.0, 14608.34262458192, 14663.706725865422, 15034.699306014038, 22597.09611615517, 22739.886300568392, 22759.772402276096, 22760.20339288117, 22826.42933926665, 9196.632134714537, 9373.671921482852, 9410.811783764286, 9486.525673716425, 9489.525523723787, 7795.14253432122, 8118.553479558563, 8517.74446766598, 8542.974843018754, 8597.5701214939, 8888.73333799987, 9154.496502692282, 9176.403533770284, 9244.214241789523, 9335.159835614828, 2583.083005533046, 2638.129417292327, 2701.5812549054535, 2735.193118030186, 2764.9308767280977, 949.8480243161199, 964.324000897515, 981.1464026297025, 991.0881988570533, 991.7173605522536, 19151.616967660568, 19577.216911323674, 19646.21415143378, 20122.094505747278, 23571.29286121419, 999.0867488758945, 1073.0664322039875, 1073.951672174754, 1075.2473268711776, 1078.196743426137, 10930.180236482296, 11203.943980280046, 11302.37836918961, 13384.0, 13832.993971333828, 482647.0, 484989.0, 486969.0, 491216.0, 504041.0, 122359.38820305842, 123168.38415808043, 123502.0, 125985.0, 126337.36831315784, 1228.81567764836, 1251.9123661343801, 1262.5139321361341, 1271.9809202861964, 1283.5828355784408, 21030.894845525676, 21230.150793968067, 21374.465638359165, 21652.35042948714, 21774.237901673365, 54469.72765136149, 54495.72752136214, 55381.0, 56356.43643563676, 56488.43511564832, 67995.0, 68138.65930670315, 68649.65675171593, 69349.65325173341, 69397.30602693908, 14075.577732668036, 14360.0, 14402.927985360006, 14428.639284017983, 14431.134131952116, 20785.168593256705, 20798.27206047781, 20829.791702082784, 22221.888890555445, 23283.301500955, 16813.579660508585, 16964.066976316422, 16970.236339365005, 17046.147692615566, 17080.316787328367, 14948.327325270606, 16035.518934431986, 16294.103824289778, 16999.98000119997, 17015.489535313962, 17725.0, 18062.187201575696, 18679.626407471504, 18684.34604788826, 18711.625767484846, 13753.656158596115, 14158.50445234412, 14472.276386180438, 14515.709685806436, 14560.927195364378, 18550.165242564388, 18660.81339186645, 18787.530311741768, 18950.0, 18974.525636859187], "value": 11903.731058494091, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.908586398952, 1363.1275983370642, 1363.2638375277352, 1369.5069774881047, 1370.609376327746, 14784.926075369622, 15436.845631543696, 15440.69118617627, 15450.768238476432, 15468.0, 14940.850591494082, 15943.441979530719, 15948.28232729527, 15968.0, 15986.360545578164, 2753.7383948524857, 2797.8041537092413, 2798.4543014112255, 2799.1322689966178, 2799.4401119776126, 2646.2325925481587, 2654.774344180747, 2726.754592086712, 2727.1818454463682, 2782.9443411131865, 2595.467929074545, 2596.948061038778, 2616.1497513308154, 2616.581346984483, 2619.0833208377107, 2708.268767432792, 2715.4297597504547, 2716.361655011071, 2720.0751744407, 2721.945561088777, 2597.6493173421723, 2623.6589243398425, 2624.829386089898, 2626.776723978464, 2628.4217472156097, 14725.926370368186, 15054.0, 15056.849431505654, 15063.774043389358, 15069.321880515294, 8059.073206581201, 8364.163583641588, 8368.832623347498, 8370.3303735701, 8375.623096960651, 5102.948970510284, 5119.641625086246, 5181.481851814789, 5248.816291429782, 5452.836414907559, 1890.7447494588191, 1905.7141428785656, 1920.596674698315, 1969.222157247879, 1970.8916009619466, 26244.0, 26683.466330673276, 26744.465110697678, 26798.464030719275, 26822.0, 6679.465642748569, 6695.765648202289, 6733.764318248838, 6851.794446166623, 6875.209350924708, 17044.829551704574, 17087.401940932257, 17092.91453542749, 17106.828931710774, 17132.40036598738, 7878.960605196938, 8053.1141574426765, 8058.838823223503, 8063.233992770677, 8066.959665201636, 7237.927620723831, 7426.183119856812, 7472.962635186789, 7485.850282994418, 7491.213422590658, 5242.659227150223, 5379.67721936685, 5412.783488660488, 5459.590530710213, 5501.037318469332, 1470.4118352659023, 1493.0742939377656, 1503.150719843285, 1551.95344139676, 1554.7434673279008, 887.6138879587401, 903.4985583001497, 904.7964208053266, 914.7758799094264, 919.5632074764567, 8224.712135075364, 8286.088530261666, 8304.252617264476, 8332.208440198172, 8380.580970951429, 1001.8597396364515, 1003.4932359158578, 1006.441425009127, 1009.1573536097294, 1024.7284469615558, 5106.259592359162, 5125.359330083739, 5268.525832675001, 5280.603954703336, 5593.356763972195, 20731.0, 21586.35240942774, 21721.131154753948, 21910.23314183996, 21940.561188776453, 20704.171833126806, 21091.261805836722, 21492.892535537223, 21792.455188620093, 21920.561588768134, 10796.67609971702, 10907.618233361953, 10923.563057477772, 10992.780144397228, 11049.613263535737, 8304.83390332202, 8348.666053357798, 8506.702265420929, 8527.573621319034, 8598.871016934625, 18602.534936626693, 18803.811961880205, 19087.618247635248, 19343.51641208981, 19486.077088436847, 18907.90546047316, 19050.714239286146, 19103.235870565022, 19107.522311942314, 19167.808321916604, 11080.39057851826, 11326.716832079264, 11329.773404532029, 11336.433178341214, 11341.149413793833, 13931.930340348234, 13945.0, 14014.719705605627, 14072.0, 14117.08238964464, 10625.840612390666, 10643.627473038407, 10727.19546034035, 10810.729731756768, 10966.342019478856, 11019.228653994463, 11074.833877492005, 11086.722831929266, 11136.276142050741, 11371.43142842871, 8997.64009439615, 9082.545872706207, 9091.363604547618, 9092.727218183465, 9098.863517047383, 6876.724931002904, 6878.071460352789, 6899.965500172467, 6938.098047253825, 6939.167299924042, 6943.791686249218, 7009.12385951756, 7022.754203602849, 7037.7184912602925, 7126.536775109601], "value": 6663.511195009412, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.3077284120755, 515.4999650339171, 537.3846945247692, 538.4588488568988, 540.1573545269378, 6378.712957916893, 6409.038644203371, 6449.129367535381, 6492.545521813469, 6496.7401303947845, 6102.420270074336, 6152.784652537162, 6184.350643182469, 6241.157443745093, 6297.370262973712, 4977.456988333628, 5054.368203974504, 5074.314967479399, 5079.746012699368, 5098.311727916721, 4908.410990681105, 5012.874678133057, 5015.699058056528, 5067.290579318898, 5080.161773307418, 4977.303177555145, 5045.470225626312, 5051.898962020758, 5065.721385323805, 5096.974515127419, 5030.874228144307, 5055.696658200502, 5077.847664570068, 5086.720230387327, 5093.643444958854, 4534.251848445003, 4558.544145585448, 4559.019810740707, 4561.589456948891, 4569.405977222973, 6222.751089956441, 6245.437910588023, 6249.187605611241, 6316.0, 6327.335629758901, 5823.708814559297, 5849.122631605251, 5862.0, 5877.853053673693, 5883.558733094992, 6592.868142637169, 6650.93349066508, 6658.400743933069, 6672.899906501407, 6745.3254674532645, 4920.114379411704, 4939.3578834751615, 4950.0842344166085, 4953.455119936804, 4984.526469985346, 7071.257517960592, 7074.0, 7104.11198600175, 7132.179799323092, 7151.427885769126, 5077.517635824591, 5085.440601533828, 5089.236614507853, 5133.589312854962, 5143.099957507421, 5148.819791307286, 5164.535191832753, 5184.585233181337, 5187.377514698185, 5210.166373380317, 5814.215080964016, 5830.970845145747, 5831.446012628793, 5842.38654941225, 5852.561057920673, 6697.7655782047395, 6705.463562914955, 6722.865542689119, 6740.932590674129, 6759.580488097555, 1689.9577510562087, 1721.1480317243045, 1724.7240441529295, 1758.7361895715744, 1776.7601373814628, 1216.3431746856597, 1220.7741567809983, 1245.5702782540009, 1247.819066235391, 1253.9498420063096, 5812.534997200214, 5823.82528524145, 5827.3007239131575, 5851.882962340729, 5870.941290587125, 6764.661766911635, 6771.3905748482875, 6775.816500377216, 6777.966110169417, 6911.861762764716, 5888.439563515672, 5901.0, 5901.370657045886, 5904.822855314347, 5930.762769489258, 3612.765170263977, 3623.4927110204594, 3635.2911182319194, 3639.217568222845, 3674.5039419678, 6705.228898676617, 6710.328967103348, 6722.378272473739, 6723.562968407038, 6724.7646332378135, 7053.964730176316, 7118.0, 7166.784996450115, 7166.856662866818, 7202.459815513753, 6709.563878347989, 6734.966325168343, 6739.191297044288, 6745.831354216184, 6760.797176084824, 6911.5853048817235, 6919.930800691928, 6927.856903611049, 6979.40675042627, 7024.6136462493005, 6849.554778939353, 6868.450523957971, 6868.484863635347, 6871.347222013901, 6874.4844136690945, 6615.338466153538, 6655.402703351064, 6751.45988320943, 6757.614688988844, 6781.93218067813, 5072.82245121419, 5086.923696144635, 5090.516400941905, 5093.18509038552, 5097.11406779494, 6660.766873159416, 6926.307369263235, 6963.825904352431, 6964.721411143498, 7010.509264351446, 6486.740530378732, 6495.675216239075, 6552.770653027312, 6579.967100164468, 6612.537122401386, 6518.545171059346, 6535.411812936859, 6636.767713130017, 6697.0, 6722.731090756511, 6537.477001839937, 6582.313904213655, 6604.24051234095, 6622.37087476689, 6673.89880669684, 6701.497387695845, 6712.9664351679885, 6731.966340168267, 6732.037903322523, 6761.290064543152, 6472.152253008661, 6500.154979852589, 6549.657320249433, 6593.109930159559, 6594.406503414716], "value": 5164.817573572787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [884.7036242858642, 885.0574138542448, 896.7130518234168, 910.3127139010046, 913.4473643445713, 18680.4395868124, 19635.410937671855, 19654.21383144676, 19703.901480492594, 19907.900460497676, 19946.70079948802, 19949.900250498762, 20123.19507219713, 20124.396268111945, 20129.899350503263, 964.5273815830245, 977.4086677560081, 984.4388698441891, 987.0228473810947, 987.5901500877127, 980.0542476510167, 981.9361741486816, 984.0110688757788, 984.099548912744, 985.1133979418508, 989.6387818446251, 1019.3628981886321, 1027.9434631095287, 1030.5774632400717, 1030.953607087679, 1018.9082982531571, 1022.2435397805644, 1022.2844009193594, 1024.0987930621043, 1024.2830018986701, 753.2016062973266, 754.3098065270326, 754.4417131322837, 754.852803703278, 755.0599503618031, 17850.821491785046, 18653.0, 19810.70283945742, 20138.295159669487, 20246.291379801783, 20654.58690826175, 20657.793422065737, 21178.470538236514, 21194.470138246514, 21218.151273949024, 16068.839311606967, 16337.754933675886, 16518.83481165185, 16647.750283745754, 16660.916695416447, 3667.7615954963107, 3686.041629176407, 3693.519842420468, 3696.149885526344, 3696.3900956342172, 124993.37503312516, 129527.35236323759, 129762.0, 130806.3459682705, 132098.3395083028, 16018.439354622533, 16447.91776041112, 16463.0, 16497.83502164987, 16522.50432487027, 30407.847960760053, 30489.08532744021, 30557.388852223277, 30690.0, 30817.2295692605, 7439.107307123179, 7648.08223013242, 7772.533647981139, 7923.722669706648, 8615.095414981462, 4199.601037901394, 4316.827326906951, 4317.633001194871, 4317.654587633045, 4319.913601727948, 5293.338332708411, 5406.243125962368, 5424.321959755031, 5441.129419292894, 5460.972695136499, 1058.6347710040025, 1076.7469644633504, 1077.0468135699805, 1080.3517889266534, 1090.6019302954523, 668.9331066893271, 683.1938312790954, 697.4873468001015, 704.4012589299157, 706.7349743846057, 12003.399830008464, 12047.0, 12249.142560020713, 12509.624711258677, 12895.0, 663.2008429842028, 678.2064983968768, 681.5399605266425, 681.9386255236954, 688.8243497908102, 5674.943250567524, 5733.655980641175, 5773.566982476331, 5842.737076831553, 6020.69896505173, 108219.45890270655, 108247.45876270568, 108472.45763771131, 109543.0, 110763.44618277019, 94626.52686736522, 96507.0, 99773.0, 102529.48735256276, 102551.0, 86126.0, 86752.56623716967, 88950.0, 90525.54737226272, 90976.54511727398, 12654.367281636065, 12907.096503244682, 12935.0, 13003.284819334649, 13014.80477792815, 40942.590574093876, 41259.7937010313, 41691.1661766769, 42017.57982420259, 43366.783166083966, 51212.0, 51330.48669513257, 52940.73529632327, 53464.46535534595, 55244.171337429165, 16281.674366512367, 16360.918195408947, 16369.42707005249, 16713.247903844112, 16789.580260493585, 20961.161553537688, 20970.685439718112, 20981.0, 21081.6837747437, 21170.04734786969, 19269.22923083061, 19357.0, 19370.2251909922, 19433.222671092997, 19520.31678891232, 18432.0, 18869.90565047166, 18949.526261843563, 18969.33607323737, 19102.808971910657, 16406.17969101564, 16502.75245871289, 16536.421225257538, 16681.499555013368, 16776.07731574726, 13852.722945541234, 14144.929275353557, 14225.502107426191, 14365.712685746017, 14435.855641443872, 12939.676508087374, 13432.731345372842, 13464.865351346753, 13489.258090804708, 13608.183508989096], "value": 9081.579700009814, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1486.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 100.0, 108.0, 107.0, 113.0, 108.0, 98.0, 108.0, 109.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 116.0, 147.0, 180.0, 119.0, 149.0, 151.0, 117.0, 165.0, 119.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 162.0, 163.0, 162.0, 164.0, 167.0, 168.0, 161.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 171.0, 75.0, 74.0, 74.0, 74.0, 160.0, 75.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 127.0, 81.0, 80.0, 79.0, 130.0, 80.0, 80.0, 122.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 148.0, 147.0, 147.0, 149.0, 147.0, 149.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 51.0, 52.0, 52.0, 53.0, 52.0, 51.0, 53.0, 53.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 75.0, 75.0, 76.0, 79.0, 73.0, 74.0, 79.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 122.0, 115.0, 119.0, 120.0, 132.0, 123.0, 144.0, 117.0, 159.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 179.0, 173.0, 177.0, 170.0, 170.0, 173.0, 171.0, 167.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 65.0, 70.0, 65.0, 76.0, 65.0, 71.0, 64.0], "value": 67.7, "unit": "score"}]}]} 03:00:02 INFO - Return code: 0 03:00:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:00:02 INFO - # TBPL SUCCESS # 03:00:02 INFO - Running post-action listener: _package_coverage_data 03:00:02 INFO - Running post-action listener: _resource_record_post_action 03:00:02 INFO - [mozharness: 2017-09-02 10:00:02.507956Z] Finished run-tests step (success) 03:00:02 INFO - Running post-run listener: _resource_record_post_run 03:00:02 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 339968; Write bytes: 401092608; Read time: 100; Write time: 223520 03:00:02 INFO - TinderboxPrint: CPU usage
13.1% 03:00:02 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 100 03:00:02 INFO - TinderboxPrint: I/O write bytes / time
401,092,608 / 223,520 03:00:02 INFO - TinderboxPrint: CPU idle
8,251.7 (86.9%) 03:00:02 INFO - TinderboxPrint: CPU user
1,193.3 (12.6%) 03:00:02 INFO - TinderboxPrint: Swap in / out
0 / 0 03:00:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109633536; Read time: 0; Write time: 74936 03:00:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:00:02 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 339968; Write bytes: 291454976; Read time: 100; Write time: 148540 03:00:03 INFO - Running post-run listener: _upload_blobber_files 03:00:03 INFO - Blob upload gear active. 03:00:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:00:03 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 03:00:03 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'] 03:00:03 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 03:00:03 INFO - (blobuploader) - INFO - Open directory for files ... 03:00:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:00:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:05 INFO - (blobuploader) - INFO - Done attempting. 03:00:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:00:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:00:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:06 INFO - (blobuploader) - INFO - Done attempting. 03:00:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:00:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:00:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:07 INFO - (blobuploader) - INFO - Done attempting. 03:00:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:00:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:14 INFO - (blobuploader) - INFO - Done attempting. 03:00:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:00:14 INFO - Return code: 0 03:00:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:00:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:00:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8fdd770fd1191d7c2df24b488d4ce4e871759eab003f7f2266693655570617e580e282bcc7df833a55af0a5288e97466f553a2c96c4fe80ebaa3c1782a2aa6d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/049844e4011cd233864dfb3280a79862890a5c44ff1cac00a2a2fd8e51b847cee01defe8c8d5a81740575913218e3db6b767db30c4fe9094d0fb356e84279772", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99dc95dfba0aeefeeee999f3cbc508984097923a398bb06504327c209fbe2dfada2298bc729d03b2e382df0bc10d206adfa452f64b89975af9e69e6a2b15c6fd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9051fc1cb0ff8d8fa0e4ec820629a8238240e4b67a43fe08b39b06bfd6b0ed43c65fa9edb9033d0fa3c8b1d88ada78c16113fcc65539c066e93618adafdc47bb"} 03:00:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:00:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:00:14 INFO - Contents: 03:00:14 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8fdd770fd1191d7c2df24b488d4ce4e871759eab003f7f2266693655570617e580e282bcc7df833a55af0a5288e97466f553a2c96c4fe80ebaa3c1782a2aa6d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/049844e4011cd233864dfb3280a79862890a5c44ff1cac00a2a2fd8e51b847cee01defe8c8d5a81740575913218e3db6b767db30c4fe9094d0fb356e84279772", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99dc95dfba0aeefeeee999f3cbc508984097923a398bb06504327c209fbe2dfada2298bc729d03b2e382df0bc10d206adfa452f64b89975af9e69e6a2b15c6fd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9051fc1cb0ff8d8fa0e4ec820629a8238240e4b67a43fe08b39b06bfd6b0ed43c65fa9edb9033d0fa3c8b1d88ada78c16113fcc65539c066e93618adafdc47bb"} 03:00:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:00:14 INFO - Copying logs to upload dir... 03:00:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:00:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.690410 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-09-02 03:00:14.598490) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-02 03:00:14.602295) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073 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/c8fdd770fd1191d7c2df24b488d4ce4e871759eab003f7f2266693655570617e580e282bcc7df833a55af0a5288e97466f553a2c96c4fe80ebaa3c1782a2aa6d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/049844e4011cd233864dfb3280a79862890a5c44ff1cac00a2a2fd8e51b847cee01defe8c8d5a81740575913218e3db6b767db30c4fe9094d0fb356e84279772", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99dc95dfba0aeefeeee999f3cbc508984097923a398bb06504327c209fbe2dfada2298bc729d03b2e382df0bc10d206adfa452f64b89975af9e69e6a2b15c6fd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9051fc1cb0ff8d8fa0e4ec820629a8238240e4b67a43fe08b39b06bfd6b0ed43c65fa9edb9033d0fa3c8b1d88ada78c16113fcc65539c066e93618adafdc47bb"} build_url:https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011760 build_url: 'https://queue.taskcluster.net/v1/task/ftQy0px5TK6bx82a3KX9nw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8fdd770fd1191d7c2df24b488d4ce4e871759eab003f7f2266693655570617e580e282bcc7df833a55af0a5288e97466f553a2c96c4fe80ebaa3c1782a2aa6d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/049844e4011cd233864dfb3280a79862890a5c44ff1cac00a2a2fd8e51b847cee01defe8c8d5a81740575913218e3db6b767db30c4fe9094d0fb356e84279772", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99dc95dfba0aeefeeee999f3cbc508984097923a398bb06504327c209fbe2dfada2298bc729d03b2e382df0bc10d206adfa452f64b89975af9e69e6a2b15c6fd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9051fc1cb0ff8d8fa0e4ec820629a8238240e4b67a43fe08b39b06bfd6b0ed43c65fa9edb9033d0fa3c8b1d88ada78c16113fcc65539c066e93618adafdc47bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-02 03:00:14.635528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 03:00:14.635874) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1504344227.731157-1878106073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 03:00:14.689871) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-02 03:00:14.690211) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-02 03:00:14.690516) ========= ========= Total master_lag: 0.27 =========