builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1503579476.36 results: success (0) revision: 892c8916ba32b7733e06bfbfdd4083ffae3ca028 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 05:57:56.357086) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 05:57:56.357579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 05:57:56.357862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 05:57:56.373909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:57:56.374272) ========= 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=652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-24 05:57:56-- 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% 224M=0s 2017-08-24 05:57:56 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.355201 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:57:56.745122) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:57:56.745456) ========= 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=652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024009 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:57:56.795204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-24 05:57:56.795546) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 892c8916ba32b7733e06bfbfdd4083ffae3ca028 --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 892c8916ba32b7733e06bfbfdd4083ffae3ca028 --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=652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-24 05:57:56,846 truncating revision to first 12 chars 2017-08-24 05:57:56,846 Setting DEBUG logging. 2017-08-24 05:57:56,846 attempt 1/10 2017-08-24 05:57:56,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/892c8916ba32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-24 05:57:57,872 unpacking tar archive at: mozilla-central-892c8916ba32/testing/mozharness/ program finished with exit code 0 elapsedTime=1.318223 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-24 05:57:58.133946) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 05:57:58.134482) ========= script_repo_revision: 892c8916ba32b7733e06bfbfdd4083ffae3ca028 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 05:57:58.135064) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 05:57:58.139466) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 05:57:58.153311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-24 05:57:58.153693) ========= /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=652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:57:58 INFO - MultiFileLogger online at 20170824 05:57:58 in /builds/slave/test 05:57:58 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 05:57:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:58 INFO - {'append_to_log': False, 05:57:58 INFO - 'base_work_dir': '/builds/slave/test', 05:57:58 INFO - 'blob_upload_branch': 'Firefox', 05:57:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:58 INFO - 'branch': 'Firefox', 05:57:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:58 INFO - 'code_coverage': False, 05:57:58 INFO - 'config_files': ('talos/linux_config.py',), 05:57:58 INFO - 'default_actions': ('clobber', 05:57:58 INFO - 'read-buildbot-config', 05:57:58 INFO - 'download-and-extract', 05:57:58 INFO - 'populate-webroot', 05:57:58 INFO - 'create-virtualenv', 05:57:58 INFO - 'install', 05:57:58 INFO - 'setup-mitmproxy', 05:57:58 INFO - 'run-tests'), 05:57:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:58 INFO - 'disable_ccov_upload': False, 05:57:58 INFO - 'download_minidump_stackwalk': True, 05:57:58 INFO - 'download_symbols': 'ondemand', 05:57:58 INFO - 'enable_stylo': False, 05:57:58 INFO - 'enable_webrender': False, 05:57:58 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:57:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:58 INFO - 'gecko_profile': False, 05:57:58 INFO - 'gecko_profile_interval': 0, 05:57:58 INFO - 'installer_path': 'installer.exe', 05:57:58 INFO - 'log_level': 'info', 05:57:58 INFO - 'log_name': 'talos', 05:57:58 INFO - 'log_to_console': True, 05:57:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:57:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:57:58 INFO - 'opt_config_files': (), 05:57:58 INFO - 'pip_index': False, 05:57:58 INFO - 'suite': 'dromaeojs-e10s', 05:57:58 INFO - 'system_bits': '32', 05:57:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:58 INFO - 'title': 'talos-linux64-ix-046', 05:57:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:58 INFO - 'use_talos_json': True, 05:57:58 INFO - 'verify': 'False', 05:57:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:58 INFO - 'work_dir': 'build'} 05:57:58 INFO - [mozharness: 2017-08-24 12:57:58.353655Z] Running clobber step. 05:57:58 INFO - Running pre-action listener: _resource_record_pre_action 05:57:58 INFO - Running main action method: clobber 05:57:58 INFO - rmtree: /builds/slave/test/build 05:57:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:57:59 INFO - Running post-action listener: _resource_record_post_action 05:57:59 INFO - [mozharness: 2017-08-24 12:57:59.385496Z] Finished clobber step (success) 05:57:59 INFO - [mozharness: 2017-08-24 12:57:59.385594Z] Running read-buildbot-config step. 05:57:59 INFO - Running pre-action listener: _resource_record_pre_action 05:57:59 INFO - Running main action method: read_buildbot_config 05:57:59 INFO - Using buildbot properties: 05:57:59 INFO - { 05:57:59 INFO - "project": "", 05:57:59 INFO - "product": "firefox", 05:57:59 INFO - "who": "ffxbld@noreply.mozilla.org", 05:57:59 INFO - "installer_path": "public/build/target.tar.bz2", 05:57:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 05:57:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:57:59 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 05:57:59 INFO - "stage_platform": "linux64-stylosequential", 05:57:59 INFO - "basedir": "/builds/slave/test", 05:57:59 INFO - "buildnumber": 208, 05:57:59 INFO - "platform": "ubuntu64_hw_styloseq", 05:57:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:57:59 INFO - "slavebuilddir": "test", 05:57:59 INFO - "taskId": "TnXudsI8RlqQ5_dHWy22VQ", 05:57:59 INFO - "branch": "mozilla-central", 05:57:59 INFO - "script_repo_revision": "production", 05:57:59 INFO - "revision": "892c8916ba32b7733e06bfbfdd4083ffae3ca028", 05:57:59 INFO - "slavename": "talos-linux64-ix-046", 05:57:59 INFO - "repo_path": "mozilla-central" 05:57:59 INFO - } 05:57:59 INFO - Finding installer, test and symbols from parent task. 05:57:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TnXudsI8RlqQ5_dHWy22VQ'}, attempt #1 05:57:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TnXudsI8RlqQ5_dHWy22VQ'}, attempt #1 05:58:00 INFO - Task dependencies: ZAmByIIwSJKylSbIRUWeYQ 05:58:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ'}, attempt #1 05:58:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2 05:58:00 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.test_packages.json 05:58:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.crashreporter-symbols.zip 05:58:00 INFO - Running post-action listener: _resource_record_post_action 05:58:00 INFO - [mozharness: 2017-08-24 12:58:00.779142Z] Finished read-buildbot-config step (success) 05:58:00 INFO - [mozharness: 2017-08-24 12:58:00.779359Z] Running download-and-extract step. 05:58:00 INFO - Running pre-action listener: _resource_record_pre_action 05:58:00 INFO - Running main action method: download_and_extract 05:58:00 INFO - mkdir: /builds/slave/test/build/tests 05:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:00 INFO - trying https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.test_packages.json 05:58:00 INFO - Downloading https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:58:01 INFO - Downloaded 989 bytes. 05:58:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:58:01 INFO - Using the following test package requirements: 05:58:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:58:01 INFO - u'common': [u'target.common.tests.zip'], 05:58:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:58:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:58:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:58:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:58:01 INFO - u'mozbase': [u'target.common.tests.zip'], 05:58:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:58:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:58:01 INFO - u'web-platform': [u'target.common.tests.zip', 05:58:01 INFO - u'target.web-platform.tests.tar.gz'], 05:58:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:58:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:58:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.common.tests.zip 05:58:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:58:01 INFO - Fetch https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.common.tests.zip into memory 05:58:02 INFO - Content-Length response header: 54979621 05:58:02 INFO - Bytes received: 54979621 05:58:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:58:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.common.tests.zip 05:58:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:58:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.common.tests.zip into memory 05:58:14 INFO - Content-Length response header: 54979621 05:58:14 INFO - Bytes received: 54979621 05:58:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.talos.tests.zip 05:58:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:58:26 INFO - Fetch https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.talos.tests.zip into memory 05:58:27 INFO - Content-Length response header: 14496384 05:58:27 INFO - Bytes received: 14496384 05:58: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')]} 05:58:27 INFO - trying https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2 05:58:27 INFO - Downloading https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:58:28 INFO - Downloaded 60928178 bytes. 05:58:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2 05:58:28 INFO - mkdir: /builds/slave/test/properties 05:58:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:28 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:28 INFO - Contents: 05:58:28 INFO - build_url:https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2 05:58:28 INFO - Running post-action listener: _resource_record_post_action 05:58:28 INFO - Running post-action listener: find_tests_for_verification 05:58:28 INFO - Running post-action listener: set_extra_try_arguments 05:58:28 INFO - [mozharness: 2017-08-24 12:58:28.667348Z] Finished download-and-extract step (success) 05:58:28 INFO - [mozharness: 2017-08-24 12:58:28.667444Z] Running populate-webroot step. 05:58:28 INFO - Running pre-action listener: _resource_record_pre_action 05:58:28 INFO - Running main action method: populate_webroot 05:58:28 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:28 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 05:58:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:28 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 05:58:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:58:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:28 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:58:28 INFO - 'talos_options': ['--stylo'], 05:58:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:58:28 INFO - 'tests': ['damp', 'tps']}, 05:58:28 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:58:28 INFO - 'talos_options': ['--stylo'], 05:58:28 INFO - 'tests': ['damp', 'tps']}, 05:58:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:58:28 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 05:58:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:58:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:58:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:58:28 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:58:28 INFO - 'talos_options': ['--stylo'], 05:58:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:58:28 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:28 INFO - 'ts_paint', 05:58:28 INFO - 'tpaint', 05:58:28 INFO - 'sessionrestore', 05:58:28 INFO - 'sessionrestore_many_windows', 05:58:28 INFO - 'sessionrestore_no_auto_restore', 05:58:28 INFO - 'tabpaint']}, 05:58:28 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 05:58:28 INFO - 'tests': ['a11yr', 05:58:28 INFO - 'ts_paint', 05:58:28 INFO - 'tpaint', 05:58:28 INFO - 'sessionrestore', 05:58:28 INFO - 'sessionrestore_many_windows', 05:58:28 INFO - 'sessionrestore_no_auto_restore', 05:58:28 INFO - 'tabpaint']}, 05:58:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:58:28 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:58:28 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 05:58:28 INFO - 'tests': ['bloom_basic_singleton']}, 05:58:28 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 05:58:28 INFO - 'tests': ['bloom_basic']}, 05:58:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:28 INFO - 'tsvgr_opacity', 05:58:28 INFO - 'tart', 05:58:28 INFO - 'tscrollx', 05:58:28 INFO - 'tsvg_static']}, 05:58:28 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 05:58:28 INFO - 'tests': ['tsvgx', 05:58:28 INFO - 'tsvgr_opacity', 05:58:28 INFO - 'tart', 05:58:28 INFO - 'tscrollx', 05:58:28 INFO - 'tsvg_static']}, 05:58:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:58:28 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:58:28 INFO - 'talos_options': ['--stylo'], 05:58:28 INFO - 'tests': ['tp5o']}, 05:58:28 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:58:28 INFO - 'talos_options': ['--mitmproxy', 05:58:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:58:28 INFO - '--firstNonBlankPaint'], 05:58:28 INFO - 'tests': ['tp6_google', 05:58:28 INFO - 'tp6_youtube', 05:58:28 INFO - 'tp6_amazon', 05:58:28 INFO - 'tp6_facebook']}, 05:58:28 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:58:28 INFO - 'talos_options': ['--stylo', 05:58:28 INFO - '--mitmproxy', 05:58:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:58:28 INFO - '--firstNonBlankPaint'], 05:58:28 INFO - 'tests': ['tp6_google', 05:58:28 INFO - 'tp6_youtube', 05:58:28 INFO - 'tp6_amazon', 05:58:28 INFO - 'tp6_facebook']}, 05:58:28 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:58:28 INFO - 'talos_options': ['--stylo', 05:58:28 INFO - '--stylo-threads=1', 05:58:28 INFO - '--mitmproxy', 05:58:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:58:28 INFO - '--firstNonBlankPaint'], 05:58:28 INFO - 'tests': ['tp6_google', 05:58:28 INFO - 'tp6_youtube', 05:58:28 INFO - 'tp6_amazon', 05:58:28 INFO - 'tp6_facebook']}, 05:58:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:58:28 INFO - 'talos_options': ['--xperf_path', 05:58:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:28 INFO - 'tests': ['tp5n']}, 05:58:28 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:58:28 INFO - 'talos_options': ['--stylo', 05:58:28 INFO - '--xperf_path', 05:58:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:28 INFO - 'tests': ['tp5n']}}} 05:58:28 INFO - Running post-action listener: _resource_record_post_action 05:58:28 INFO - [mozharness: 2017-08-24 12:58:28.681802Z] Finished populate-webroot step (success) 05:58:28 INFO - [mozharness: 2017-08-24 12:58:28.681892Z] Running create-virtualenv step. 05:58:28 INFO - Running pre-action listener: _resource_record_pre_action 05:58:28 INFO - Running main action method: create_virtualenv 05:58:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:28 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:58:28 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:58:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:58:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:29 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:29 INFO - Installing pip...............done. 05:58:29 INFO - Return code: 0 05:58:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:58:29 INFO - Reading from file tmpfile_stdout 05:58:29 INFO - Output received: 05:58:29 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:58:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce130>, '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 0x2bcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf4c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', '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 05:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:58:29 INFO - Using env: {'DISPLAY': ':0', 05:58:29 INFO - 'HOME': '/home/cltbld', 05:58:29 INFO - 'LANG': 'en_US.UTF-8', 05:58:29 INFO - 'LANGUAGE': 'en_US:en', 05:58:29 INFO - 'LOGNAME': 'cltbld', 05:58:29 INFO - 'MAIL': '/var/mail/cltbld', 05:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:29 INFO - 'MOZ_NO_REMOTE': '1', 05:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:29 INFO - 'NO_EM_RESTART': '1', 05:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:29 INFO - 'PWD': '/builds/slave/test', 05:58:29 INFO - 'SHELL': '/bin/bash', 05:58:29 INFO - 'SHLVL': '1', 05:58:29 INFO - 'TERM': 'linux', 05:58:29 INFO - 'TMOUT': '86400', 05:58:29 INFO - 'USER': 'cltbld', 05:58:29 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', 05:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:29 INFO - '_': '/tools/buildbot/bin/python'} 05:58:30 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:58:30 INFO - Downloading/unpacking pip>=1.5 05:58:30 INFO - Running setup.py egg_info for package pip 05:58:30 INFO - warning: no files found matching 'pip/cacert.pem' 05:58:30 INFO - warning: no files found matching '*.html' under directory 'docs' 05:58:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:58:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:58:30 INFO - Installing collected packages: pip 05:58:30 INFO - Found existing installation: pip 1.1 05:58:30 INFO - Uninstalling pip: 05:58:30 INFO - Successfully uninstalled pip 05:58:30 INFO - Running setup.py install for pip 05:58:30 INFO - warning: no files found matching 'pip/cacert.pem' 05:58:30 INFO - warning: no files found matching '*.html' under directory 'docs' 05:58:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:58:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:58:30 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:58:30 INFO - Successfully installed pip 05:58:30 INFO - Cleaning up... 05:58:30 INFO - Return code: 0 05:58:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:30 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')]} 05:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:30 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')]} 05:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:30 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 0x28621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce130>, '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 0x2bcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf4c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', '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 05:58:30 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 05:58:30 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 05:58:30 INFO - Using env: {'DISPLAY': ':0', 05:58:30 INFO - 'HOME': '/home/cltbld', 05:58:30 INFO - 'LANG': 'en_US.UTF-8', 05:58:30 INFO - 'LANGUAGE': 'en_US:en', 05:58:30 INFO - 'LOGNAME': 'cltbld', 05:58:30 INFO - 'MAIL': '/var/mail/cltbld', 05:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:30 INFO - 'MOZ_NO_REMOTE': '1', 05:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:30 INFO - 'NO_EM_RESTART': '1', 05:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:30 INFO - 'PWD': '/builds/slave/test', 05:58:30 INFO - 'SHELL': '/bin/bash', 05:58:30 INFO - 'SHLVL': '1', 05:58:30 INFO - 'TERM': 'linux', 05:58:30 INFO - 'TMOUT': '86400', 05:58:30 INFO - 'USER': 'cltbld', 05:58:30 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', 05:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:30 INFO - '_': '/tools/buildbot/bin/python'} 05:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:31 INFO - Downloading/unpacking psutil>=3.1.1 05:58:31 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 05:58:31 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 05:58:31 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 05:58:31 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 05:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:32 INFO - Installing collected packages: psutil 05:58:32 INFO - Running setup.py install for psutil 05:58:32 INFO - building 'psutil._psutil_linux' extension 05:58:32 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 05:58:32 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 05:58:32 INFO - building 'psutil._psutil_posix' extension 05:58:32 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 05:58:32 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 05:58:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:32 INFO - Successfully installed psutil 05:58:32 INFO - Cleaning up... 05:58:32 INFO - Return code: 0 05:58:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:32 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')]} 05:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:32 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')]} 05:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:32 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 0x28621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce130>, '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 0x2bcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf4c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', '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 05:58:32 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 05:58:32 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 05:58:32 INFO - Using env: {'DISPLAY': ':0', 05:58:32 INFO - 'HOME': '/home/cltbld', 05:58:32 INFO - 'LANG': 'en_US.UTF-8', 05:58:32 INFO - 'LANGUAGE': 'en_US:en', 05:58:32 INFO - 'LOGNAME': 'cltbld', 05:58:32 INFO - 'MAIL': '/var/mail/cltbld', 05:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:32 INFO - 'MOZ_NO_REMOTE': '1', 05:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:32 INFO - 'NO_EM_RESTART': '1', 05:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:32 INFO - 'PWD': '/builds/slave/test', 05:58:32 INFO - 'SHELL': '/bin/bash', 05:58:32 INFO - 'SHLVL': '1', 05:58:32 INFO - 'TERM': 'linux', 05:58:32 INFO - 'TMOUT': '86400', 05:58:32 INFO - 'USER': 'cltbld', 05:58:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', 05:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:32 INFO - '_': '/tools/buildbot/bin/python'} 05:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:34 INFO - Installing collected packages: mozsystemmonitor 05:58:34 INFO - Running setup.py install for mozsystemmonitor 05:58:34 INFO - Successfully installed mozsystemmonitor 05:58:34 INFO - Cleaning up... 05:58:34 INFO - Return code: 0 05:58:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:58:34 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')]} 05:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:34 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')]} 05:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:34 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 0x28621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce130>, '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 0x2bcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf4c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', '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 05:58:34 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 05:58:34 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 05:58:34 INFO - Using env: {'DISPLAY': ':0', 05:58:34 INFO - 'HOME': '/home/cltbld', 05:58:34 INFO - 'LANG': 'en_US.UTF-8', 05:58:34 INFO - 'LANGUAGE': 'en_US:en', 05:58:34 INFO - 'LOGNAME': 'cltbld', 05:58:34 INFO - 'MAIL': '/var/mail/cltbld', 05:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:34 INFO - 'MOZ_NO_REMOTE': '1', 05:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:34 INFO - 'NO_EM_RESTART': '1', 05:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:34 INFO - 'PWD': '/builds/slave/test', 05:58:34 INFO - 'SHELL': '/bin/bash', 05:58:34 INFO - 'SHLVL': '1', 05:58:34 INFO - 'TERM': 'linux', 05:58:34 INFO - 'TMOUT': '86400', 05:58:34 INFO - 'USER': 'cltbld', 05:58:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', 05:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:34 INFO - '_': '/tools/buildbot/bin/python'} 05:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:34 INFO - Downloading/unpacking jsonschema==2.5.1 05:58:34 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 05:58:34 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 05:58:34 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 05:58:34 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 05:58:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:35 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:35 INFO - warning: no files found matching '*.txt' 05:58:35 INFO - no previously-included directories found matching 'build' 05:58:35 INFO - no previously-included directories found matching 'dist' 05:58:35 INFO - no previously-included directories found matching '.git*' 05:58:35 INFO - Installing collected packages: jsonschema, functools32 05:58:35 INFO - Running setup.py install for functools32 05:58:35 INFO - warning: no files found matching '*.txt' 05:58:35 INFO - no previously-included directories found matching 'build' 05:58:35 INFO - no previously-included directories found matching 'dist' 05:58:35 INFO - no previously-included directories found matching '.git*' 05:58:35 INFO - Successfully installed jsonschema functools32 05:58:35 INFO - Cleaning up... 05:58:35 INFO - Return code: 0 05:58:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce130>, '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 0x2bcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf4c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', '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 05:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:58:36 INFO - Using env: {'DISPLAY': ':0', 05:58:36 INFO - 'HOME': '/home/cltbld', 05:58:36 INFO - 'LANG': 'en_US.UTF-8', 05:58:36 INFO - 'LANGUAGE': 'en_US:en', 05:58:36 INFO - 'LOGNAME': 'cltbld', 05:58:36 INFO - 'MAIL': '/var/mail/cltbld', 05:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:36 INFO - 'MOZ_NO_REMOTE': '1', 05:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:36 INFO - 'NO_EM_RESTART': '1', 05:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:36 INFO - 'PWD': '/builds/slave/test', 05:58:36 INFO - 'SHELL': '/bin/bash', 05:58:36 INFO - 'SHLVL': '1', 05:58:36 INFO - 'TERM': 'linux', 05:58:36 INFO - 'TMOUT': '86400', 05:58:36 INFO - 'USER': 'cltbld', 05:58:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', 05:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:36 INFO - '_': '/tools/buildbot/bin/python'} 05:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:58:36 INFO - Cleaning up... 05:58:36 INFO - Return code: 0 05:58:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce130>, '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 0x2bcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf4c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', '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 05:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:58:36 INFO - Using env: {'DISPLAY': ':0', 05:58:36 INFO - 'HOME': '/home/cltbld', 05:58:36 INFO - 'LANG': 'en_US.UTF-8', 05:58:36 INFO - 'LANGUAGE': 'en_US:en', 05:58:36 INFO - 'LOGNAME': 'cltbld', 05:58:36 INFO - 'MAIL': '/var/mail/cltbld', 05:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:36 INFO - 'MOZ_NO_REMOTE': '1', 05:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:36 INFO - 'NO_EM_RESTART': '1', 05:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:36 INFO - 'PWD': '/builds/slave/test', 05:58:36 INFO - 'SHELL': '/bin/bash', 05:58:36 INFO - 'SHLVL': '1', 05:58:36 INFO - 'TERM': 'linux', 05:58:36 INFO - 'TMOUT': '86400', 05:58:36 INFO - 'USER': 'cltbld', 05:58:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', 05:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:36 INFO - '_': '/tools/buildbot/bin/python'} 05:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:36 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:38 INFO - Downloading docopt-0.6.1.tar.gz 05:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:38 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:38 INFO - Running setup.py install for blobuploader 05:58:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:38 INFO - Running setup.py install for requests 05:58:38 INFO - Running setup.py install for docopt 05:58:38 INFO - Successfully installed blobuploader requests docopt 05:58:38 INFO - Cleaning up... 05:58:38 INFO - Return code: 0 05:58:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:38 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 0x28621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce130>, '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 0x2bcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf4c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', '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 05:58:38 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 05:58:38 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 05:58:38 INFO - Using env: {'DISPLAY': ':0', 05:58:38 INFO - 'HOME': '/home/cltbld', 05:58:38 INFO - 'LANG': 'en_US.UTF-8', 05:58:38 INFO - 'LANGUAGE': 'en_US:en', 05:58:38 INFO - 'LOGNAME': 'cltbld', 05:58:38 INFO - 'MAIL': '/var/mail/cltbld', 05:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:38 INFO - 'MOZ_NO_REMOTE': '1', 05:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:38 INFO - 'NO_EM_RESTART': '1', 05:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:38 INFO - 'PWD': '/builds/slave/test', 05:58:38 INFO - 'SHELL': '/bin/bash', 05:58:38 INFO - 'SHLVL': '1', 05:58:38 INFO - 'TERM': 'linux', 05:58:38 INFO - 'TMOUT': '86400', 05:58:38 INFO - 'USER': 'cltbld', 05:58:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', 05:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:38 INFO - '_': '/tools/buildbot/bin/python'} 05:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:38 INFO - Running setup.py (path:/tmp/pip-OVxnUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:38 INFO - Running setup.py (path:/tmp/pip-VV741l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:39 INFO - Running setup.py (path:/tmp/pip-R762HY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:39 INFO - Running setup.py (path:/tmp/pip-dInHS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:39 INFO - Running setup.py (path:/tmp/pip-j6ULcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:39 INFO - Running setup.py (path:/tmp/pip-WCvpb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:39 INFO - Running setup.py (path:/tmp/pip-GWFSuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:39 INFO - Running setup.py (path:/tmp/pip-qt3LXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:39 INFO - Running setup.py (path:/tmp/pip-irdFiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:39 INFO - Running setup.py (path:/tmp/pip-8_R2TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:39 INFO - Running setup.py (path:/tmp/pip-AfbSvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:39 INFO - Running setup.py (path:/tmp/pip-QgAiia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:39 INFO - Running setup.py (path:/tmp/pip-I0BDgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:39 INFO - Running setup.py (path:/tmp/pip-od2j43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:39 INFO - Running setup.py (path:/tmp/pip-wOAWIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:39 INFO - Running setup.py (path:/tmp/pip-pFQ7Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:40 INFO - Running setup.py (path:/tmp/pip-6LqROa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:40 INFO - Running setup.py install for manifestparser 05:58:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:40 INFO - Running setup.py install for mozcrash 05:58:40 INFO - Running setup.py install for mozdebug 05:58:40 INFO - Running setup.py install for mozdevice 05:58:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:40 INFO - Running setup.py install for mozfile 05:58:40 INFO - Running setup.py install for mozhttpd 05:58:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:40 INFO - Running setup.py install for mozinfo 05:58:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:40 INFO - Running setup.py install for mozInstall 05:58:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:40 INFO - Running setup.py install for mozleak 05:58:40 INFO - Running setup.py install for mozlog 05:58:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for moznetwork 05:58:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozprocess 05:58:41 INFO - Running setup.py install for mozprofile 05:58:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozrunner 05:58:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Running setup.py install for mozscreenshot 05:58:41 INFO - Running setup.py install for moztest 05:58:41 INFO - Running setup.py install for mozversion 05:58:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:41 INFO - Cleaning up... 05:58:41 INFO - Return code: 0 05:58:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:41 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 0x28621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce130>, '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 0x2bcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf4c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', '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 05:58:41 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 05:58:41 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 05:58:41 INFO - Using env: {'DISPLAY': ':0', 05:58:41 INFO - 'HOME': '/home/cltbld', 05:58:41 INFO - 'LANG': 'en_US.UTF-8', 05:58:41 INFO - 'LANGUAGE': 'en_US:en', 05:58:41 INFO - 'LOGNAME': 'cltbld', 05:58:41 INFO - 'MAIL': '/var/mail/cltbld', 05:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:41 INFO - 'MOZ_NO_REMOTE': '1', 05:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:41 INFO - 'NO_EM_RESTART': '1', 05:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:41 INFO - 'PWD': '/builds/slave/test', 05:58:41 INFO - 'SHELL': '/bin/bash', 05:58:41 INFO - 'SHLVL': '1', 05:58:41 INFO - 'TERM': 'linux', 05:58:41 INFO - 'TMOUT': '86400', 05:58:41 INFO - 'USER': 'cltbld', 05:58:41 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', 05:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:41 INFO - '_': '/tools/buildbot/bin/python'} 05:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:42 INFO - Running setup.py (path:/tmp/pip-htfl05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:42 INFO - Running setup.py (path:/tmp/pip-TiQ63K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:42 INFO - Running setup.py (path:/tmp/pip-7mWQeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:42 INFO - Running setup.py (path:/tmp/pip-9FOacR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:42 INFO - Running setup.py (path:/tmp/pip-iFycqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:42 INFO - Running setup.py (path:/tmp/pip-jAyJCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:42 INFO - Running setup.py (path:/tmp/pip-Z9ZOtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:42 INFO - Running setup.py (path:/tmp/pip-byPbrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:42 INFO - Running setup.py (path:/tmp/pip-e64s8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:42 INFO - Running setup.py (path:/tmp/pip-tA04qU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:42 INFO - Running setup.py (path:/tmp/pip-Vuc4K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:42 INFO - Running setup.py (path:/tmp/pip-P75nqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:42 INFO - Running setup.py (path:/tmp/pip-HJyYrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:43 INFO - Running setup.py (path:/tmp/pip-2Gxbwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:43 INFO - Running setup.py (path:/tmp/pip-pytjmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:43 INFO - Running setup.py (path:/tmp/pip-UA9fH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:43 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)) 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:43 INFO - Running setup.py (path:/tmp/pip-XYqs_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:43 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)) 05:58:43 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)) 05:58:43 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)) 05:58:43 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)) 05:58:43 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)) 05:58:43 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)) 05:58:43 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)) 05:58:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:43 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 05:58:43 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 05:58:43 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 05:58:43 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 05:58:44 INFO - Downloading blessings-1.6.tar.gz 05:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:44 INFO - Installing collected packages: blessings 05:58:44 INFO - Running setup.py install for blessings 05:58:44 INFO - Successfully installed blessings 05:58:44 INFO - Cleaning up... 05:58:44 INFO - Return code: 0 05:58:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:44 INFO - Reading from file tmpfile_stdout 05:58:44 INFO - Current package versions: 05:58:44 INFO - argparse == 1.2.1 05:58:44 INFO - blessings == 1.6 05:58:44 INFO - blobuploader == 1.2.4 05:58:44 INFO - docopt == 0.6.1 05:58:44 INFO - functools32 == 3.2.3-2 05:58:44 INFO - jsonschema == 2.5.1 05:58:44 INFO - manifestparser == 1.1 05:58:44 INFO - mozInstall == 1.13 05:58:44 INFO - mozcrash == 1.0 05:58:44 INFO - mozdebug == 0.1 05:58:44 INFO - mozdevice == 0.51 05:58:44 INFO - mozfile == 1.2 05:58:44 INFO - mozhttpd == 0.7 05:58:44 INFO - mozinfo == 0.10 05:58:44 INFO - mozleak == 0.1 05:58:44 INFO - mozlog == 3.5 05:58:44 INFO - moznetwork == 0.27 05:58:44 INFO - mozprocess == 0.25 05:58:44 INFO - mozprofile == 0.28 05:58:44 INFO - mozrunner == 6.13 05:58:44 INFO - mozscreenshot == 0.1 05:58:44 INFO - mozsystemmonitor == 0.3 05:58:44 INFO - moztest == 0.8 05:58:44 INFO - mozversion == 1.4 05:58:44 INFO - psutil == 3.1.1 05:58:44 INFO - requests == 1.2.3 05:58:44 INFO - wsgiref == 0.1.2 05:58:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:44 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 0x28621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce130>, '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 0x2bcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf4c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', '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 05:58:44 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 05:58:44 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 05:58:44 INFO - Using env: {'DISPLAY': ':0', 05:58:44 INFO - 'HOME': '/home/cltbld', 05:58:44 INFO - 'LANG': 'en_US.UTF-8', 05:58:44 INFO - 'LANGUAGE': 'en_US:en', 05:58:44 INFO - 'LOGNAME': 'cltbld', 05:58:44 INFO - 'MAIL': '/var/mail/cltbld', 05:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:44 INFO - 'MOZ_NO_REMOTE': '1', 05:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:44 INFO - 'NO_EM_RESTART': '1', 05:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:44 INFO - 'PWD': '/builds/slave/test', 05:58:44 INFO - 'SHELL': '/bin/bash', 05:58:44 INFO - 'SHLVL': '1', 05:58:44 INFO - 'TERM': 'linux', 05:58:44 INFO - 'TMOUT': '86400', 05:58:44 INFO - 'USER': 'cltbld', 05:58:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', 05:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:44 INFO - '_': '/tools/buildbot/bin/python'} 05:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58:45 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:58:46 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)) 05:58:46 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)) 05:58:46 INFO - Installing collected packages: simplejson 05:58:46 INFO - Running setup.py install for simplejson 05:58:46 INFO - building 'simplejson._speedups' extension 05:58:46 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 05:58:47 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 05:58:47 INFO - Successfully installed simplejson 05:58:47 INFO - Cleaning up... 05:58:47 INFO - Return code: 0 05:58:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bce130>, '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 0x2bcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf4c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', '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 05:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:58:47 INFO - Using env: {'DISPLAY': ':0', 05:58:47 INFO - 'HOME': '/home/cltbld', 05:58:47 INFO - 'LANG': 'en_US.UTF-8', 05:58:47 INFO - 'LANGUAGE': 'en_US:en', 05:58:47 INFO - 'LOGNAME': 'cltbld', 05:58:47 INFO - 'MAIL': '/var/mail/cltbld', 05:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:47 INFO - 'MOZ_NO_REMOTE': '1', 05:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:47 INFO - 'NO_EM_RESTART': '1', 05:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:47 INFO - 'PWD': '/builds/slave/test', 05:58:47 INFO - 'SHELL': '/bin/bash', 05:58:47 INFO - 'SHLVL': '1', 05:58:47 INFO - 'TERM': 'linux', 05:58:47 INFO - 'TMOUT': '86400', 05:58:47 INFO - 'USER': 'cltbld', 05:58:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', 05:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:47 INFO - '_': '/tools/buildbot/bin/python'} 05:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:58:47 INFO - Cleaning up... 05:58:47 INFO - Return code: 0 05:58:47 INFO - Running post-action listener: _resource_record_post_action 05:58:47 INFO - Running post-action listener: _start_resource_monitoring 05:58:47 INFO - Starting resource monitoring. 05:58:47 INFO - [mozharness: 2017-08-24 12:58:47.541364Z] Finished create-virtualenv step (success) 05:58:47 INFO - [mozharness: 2017-08-24 12:58:47.541837Z] Running install step. 05:58:47 INFO - Running pre-action listener: _resource_record_pre_action 05:58:47 INFO - Running main action method: install 05:58:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:47 INFO - Reading from file tmpfile_stdout 05:58:47 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:47 INFO - Reading from file tmpfile_stdout 05:58:47 INFO - Output received: 05:58:47 INFO - Usage: mozinstall [options] installer 05:58:47 INFO - Options: 05:58:47 INFO - -h, --help show this help message and exit 05:58:47 INFO - -d DEST, --destination=DEST 05:58:47 INFO - Directory to install application into. [default: 05:58:47 INFO - "/builds/slave/test"] 05:58:47 INFO - --app=APP Application being installed. [default: firefox] 05:58:47 INFO - mkdir: /builds/slave/test/build/application 05:58:47 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'] 05:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:59:05 INFO - Reading from file tmpfile_stdout 05:59:05 INFO - Output received: 05:59:05 INFO - /builds/slave/test/build/application/firefox/firefox 05:59:05 INFO - Running post-action listener: _resource_record_post_action 05:59:05 INFO - [mozharness: 2017-08-24 12:59:05.694449Z] Finished install step (success) 05:59:05 INFO - [mozharness: 2017-08-24 12:59:05.694701Z] Running setup-mitmproxy step. 05:59:05 INFO - Running pre-action listener: _resource_record_pre_action 05:59:05 INFO - Running main action method: setup_mitmproxy 05:59:05 INFO - Skipping: mitmproxy is not required 05:59:05 INFO - Running post-action listener: _resource_record_post_action 05:59:05 INFO - [mozharness: 2017-08-24 12:59:05.695840Z] Finished setup-mitmproxy step (success) 05:59:05 INFO - [mozharness: 2017-08-24 12:59:05.696061Z] Running run-tests step. 05:59:05 INFO - Running pre-action listener: _resource_record_pre_action 05:59:05 INFO - Running pre-action listener: _set_gcov_prefix 05:59:05 INFO - Running main action method: run_tests 05:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:05 INFO - Python 2.7.3 05:59:05 INFO - Return code: 0 05:59:05 INFO - grabbing minidump binary from tooltool 05:59: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')]} 05:59:05 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 0x2bce130>, '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 0x2bcf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcf4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:05 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 05:59:05 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 05:59:05 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 05:59:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:05 INFO - Return code: 0 05:59:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:59:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:05 INFO - ENV: RUST_BACKTRACE is now full 05:59:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:59:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:05 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/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:59:05 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/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 05:59:05 INFO - Using env: {'DISPLAY': ':0', 05:59:05 INFO - 'HOME': '/home/cltbld', 05:59:05 INFO - 'LANG': 'en_US.UTF-8', 05:59:05 INFO - 'LANGUAGE': 'en_US:en', 05:59:05 INFO - 'LOGNAME': 'cltbld', 05:59:05 INFO - 'MAIL': '/var/mail/cltbld', 05:59:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:05 INFO - 'MOZ_NO_REMOTE': '1', 05:59:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:05 INFO - 'NO_EM_RESTART': '1', 05:59:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:05 INFO - 'PWD': '/builds/slave/test', 05:59:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:05 INFO - 'RUST_BACKTRACE': 'full', 05:59:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:59:05 INFO - 'SHELL': '/bin/bash', 05:59:05 INFO - 'SHLVL': '1', 05:59:05 INFO - 'STYLO_FORCE_ENABLED': '1', 05:59:05 INFO - 'TERM': 'linux', 05:59:05 INFO - 'TMOUT': '86400', 05:59:05 INFO - 'USER': 'cltbld', 05:59:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744', 05:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:05 INFO - '_': '/tools/buildbot/bin/python'} 05:59:05 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/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:59:06 INFO - mozversion application_buildid: 20170824120051 05:59:06 INFO - mozversion application_changeset: 892c8916ba32b7733e06bfbfdd4083ffae3ca028 05:59:06 INFO - mozversion application_display_name: Nightly 05:59:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:06 INFO - mozversion application_name: Firefox 05:59:06 INFO - mozversion application_remotingname: firefox 05:59:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:59:06 INFO - mozversion application_vendor: Mozilla 05:59:06 INFO - mozversion application_version: 57.0a1 05:59:06 INFO - mozversion platform_buildid: 20170824120051 05:59:06 INFO - mozversion platform_changeset: 892c8916ba32b7733e06bfbfdd4083ffae3ca028 05:59:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:59:06 INFO - mozversion platform_version: 57.0a1 05:59:06 INFO - using testdate: 1503579546 05:59:06 INFO - actual date: 1503579546 05:59:06 INFO - starting webserver on 'localhost:51188' 05:59:06 INFO - SUITE-START | Running 2 tests 05:59:06 INFO - TEST-START | dromaeo_css 05:59:06 INFO - Initialising browser for dromaeo_css test... 05:59:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51188/getInfo.html -profile /tmp/tmpj96f8Q/profile 05:59:06 INFO - TEST-INFO | started process 17795 (/builds/slave/test/build/application/firefox/firefox http://localhost:51188/getInfo.html) 05:59:11 INFO - TEST-INFO | 17795: exit 0 05:59:11 INFO - Browser initialized. 05:59:11 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:11 INFO - TEST-INFO | started process 17983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj96f8Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:12 INFO - PID 17983 | 05:59:12 INFO - PID 17983 | (/builds/slave/test/build/application/firefox/firefox:18032): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:59:12 INFO - PID 17983 | 05:59:13 INFO - PID 17983 | 05:59:13 INFO - PID 17983 | (/builds/slave/test/build/application/firefox/firefox:18095): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:59:13 INFO - PID 17983 | 05:59:13 INFO - PID 17983 | __metrics Screen width/height:1600/1200 05:59:13 INFO - PID 17983 | colorDepth:24 05:59:13 INFO - PID 17983 | Browser inner width/height: 1024/768 05:59:13 INFO - PID 17983 | __metrics 05:59:23 INFO - PID 17983 | RSS: Main: 175009792 05:59:23 INFO - PID 17983 | 06:00:16 INFO - PID 17983 | [Parent 17983] WARNING: pipe error: Broken pipe: file /home/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 709 06:02:21 INFO - PID 17983 | Cycle 1(1): loaded http://localhost:51188/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51188/tests/dromaeo/cssquery-ext.html) 06:02:22 INFO - PID 17983 | RSS: Main: 178421760 06:02:22 INFO - PID 17983 | 06:05:24 INFO - PID 17983 | Cycle 1(1): loaded http://localhost:51188/tests/dromaeo/cssquery-ext.html (next: http://localhost:51188/tests/dromaeo/cssquery-jquery.html) 06:05:25 INFO - PID 17983 | RSS: Main: 174796800 06:05:25 INFO - PID 17983 | 06:08:27 INFO - PID 17983 | Cycle 1(1): loaded http://localhost:51188/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51188/tests/dromaeo/cssquery-mootools.html) 06:08:27 INFO - PID 17983 | RSS: Main: 177393664 06:08:27 INFO - PID 17983 | 06:11:29 INFO - PID 17983 | Cycle 1(1): loaded http://localhost:51188/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51188/tests/dromaeo/cssquery-prototype.html) 06:11:30 INFO - PID 17983 | RSS: Main: 175579136 06:11:30 INFO - PID 17983 | 06:14:33 INFO - PID 17983 | Cycle 1(1): loaded http://localhost:51188/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51188/tests/dromaeo/cssquery-yui.html) 06:14:34 INFO - PID 17983 | RSS: Main: 179724288 06:14:34 INFO - PID 17983 | 06:17:36 INFO - PID 17983 | Cycle 1(1): loaded http://localhost:51188/tests/dromaeo/cssquery-yui.html (next: http://localhost:51188/tests/dromaeo/cssquery-dojo.html) 06:17:36 INFO - PID 17983 | RSS: Main: 180510720 06:17:36 INFO - PID 17983 | 06:17:36 INFO - PID 17983 | __start_tp_report 06:17:36 INFO - PID 17983 | _x_x_mozilla_page_load 06:17:36 INFO - PID 17983 | _x_x_mozilla_page_load_details 06:17:36 INFO - PID 17983 | |i|pagename|runs| 06:17:36 INFO - PID 17983 | |0;dojo.html;3253.1704415374074;3279.3769183855075;3282.392757339891;3284.310294838084;3331.1172539277095;6139.293981192164;6183.9690801545985;6221;6229.781957631484;6247.125402443661;6083.543734219929;6214.65819379934;6217.5025997920175;6331.240251169855;6340.809775706736;5696.259486266779;5756.740946657411;5774.971125144369;5794.942050579482;5808.883822323551;918.4791908503558;5506.174073888928;5653.632513886584;5702.45826646468;5817.854553636172;5690.374058853523;5710.514606258453;5746.339170995327;5782.45066718661;5786.103154011135;5642.351129620064;5658.43415658435;5699.202111704365;5719.3422756382715;5725.656460612335;5679.290088738908;5742.655440673573;5754.97122514389;5779;5781.710914454303;6083.9391606084255;6154.169187159721;6192.721327540272;6201.751929922798;6253.405926436982;6574.539782215247;6581.177352830896;6619.569727967715;6626.2048554173325;6626.86746265072;6586.37429444202;6680.432163266129;6680.498962577777;6696.129503164558;6696.799096027127;6133.049377346474;6187.535934804908;6190.752369905198;6191.380861913818;6201.441870231701;6909.378155965987;6928.307169283132;6936.653167341613;6943.132108486439;6965.825854353681;6558.442532384705;6565.146530950946;6650;6655.101561289261;6666.233383160901;6543.770968016192;6676.232233293234;6684.2647308795995;6767.086443330186;6768.56004359715;6550.410463058348;6551.1155993941165;6554.442872355808;6555.016747487915;6563.868722625521;5824.417558244227;6580.901286480706;6589.374009469093;6590.373914478117;6593.86812263752;5229.790808367698;5242.082635538765;5296.894062118813;5298.311219541435;5299.8410047698635;4506.639468842484;4583.839565615188;4608.400907882021;4617.653675974316;4648.7443190624845;5734.340550836707;5738.741756620962;5756.683382413924;5767.192593036978;5778.797742079007;6696.46428285736;6696.799096027127;6716.865662686719;6719.865602687919;6725.764598239038;5781.4507621775865;5784;5824.563157763185;5864.120381942657;5865.149553314745;5735.340435849931;5738.8278351649515;5802.535797136304;5812.041013232853;5823.592348535646;6369.840753981188;6500.187476565429;6505.41451269388;6506.3818937200895;6602.669866506655;6529.11856899322;6556.770513032021;6566;6696.263411024686;6711.0940023096255;6346.2067241594805;6424.164858568356;6428.003659432796;6433.839154021;6467.320931302145;6417.1657684500715;6426.389492998158;6506.577072490273;6515.771947981987;6536.575122617015;6555.049517819984;6560.475161986934;6581.473482121323;6656.30108838565;6658.300878407697;6385.553011289351;6418.55070145104;6430.421262086435;6434.227892652912;6434.356564343529;6356.77751278703;6411.96794016027;6438.356164383524;6446.09754634361;6450.903236451363;6439.130717353098;6452.387023232785;6457.128287681291;6460.741570337133;6468.741250349934;6450.41946224842;6566.868662626625;6566.883629782853;6599.505037122139;6605.174353205849;6296.716647750954;6302.401271879165;6315.5263355247625;6388.425041746079;6408.263049749152 06:17:36 INFO - PID 17983 | |1;ext.html;763.1910175214273;832.1428928203952;843.8860753798238;866.5493943149562;874.5321253129573;38858;39558.406623900664;39631.00922476936;39675.40486892692;39715.60284397155;35955.10112247195;36101.45847812278;36170.45744313837;36193.0951726207;36405.27189456216;6767.187937447513;6818.897716534256;6821.351971562718;6947.340002699761;6959.61722105284;7334.193238743734;7502.774916752479;7561.319481246686;7561.773146805577;7562.735304264352;7546.396288296923;7555.168931417567;7599.620018999056;7607.505512141721;7609;7283.745068922589;7521.172671006212;7542.170361260257;7551.433642476809;7572.318491335806;7381.88927166093;7426.517276377018;7440.404767618577;7451.2921272479025;7455.813604659873;35388.823055884815;35644.28711425783;35663.64336356629;35666.108347291265;35714.28571428557;3500.6149323574386;3533.152043509565;3533.9116522086897;3535.3106144301873;3537.9469307960403;30255.394892102035;30361.848190758905;30408.391832163234;30429.391412171855;30478.238044048856;4874.634402419832;4945.727984960826;4950.801967921278;5025.296458495814;5044.495550444926;173249;174316;174844;176289;176422;45568.54431455709;45621.175152994176;45778.31332530015;45864;45977.31034034492;47459.28811067837;47830.760846196245;47853.521464784906;48098.519014809404;48213;15407.61480962985;15694.293756780973;15729.606759831096;15744.763828542582;15774.921125394529;13005.674858128434;13006.219626822232;13008.869911300955;13011.349432528335;13052.34738263083;13912;13927.930360348337;13940.302984850718;14084.15495070299;14146;5433.429489903582;5433.538149257357;5460.590455715837;5484.478974497496;5558.527525160326;983.9458829764432;985.1084768284713;988.4563490080427;993.2103977337889;1003.247564326755;21684.783152168275;21922.123115075537;22022.88988555047;22082.11671533153;22490.100395984304;1073.1575713065206;1090.3294473898654;1093.5899037860802;1094.5676457799125;1104.718296834302;11454.198206125491;11845.822312665317;11918.523259069714;11941.223820451643;12023.857733515302;224541;226294;227296;227435;227599;44777;44909.55090449119;53199.20201196985;53720.731396342766;54079.72960135253;1433.8781203597812;1439.4817865568386;1444.169602478579;1452.5206681794982;1455.7889106079558;26842.620527062678;26970.460590788465;27019.32451688645;27109.86445067762;27297.590536141575;37187.81406092952;37421.81289093537;37500.24999500049;37507.81246093752;37525.81237093797;194426;195370;196080;196169;198039;32981.67018329786;34178.82910585431;34262;34272.485912711825;34552;41188.1762364757;41389.1722165561;41409.37885931653;41462.79268603758;41645;30577.388452230385;30579;30792.23019424443;30943.535846962764;31222.843885780425;30877.8456107718;31211.687883120878;31337.37325253528;31344.686553134175;31654.841725791222;33579.328413432086;34236.82881585676;34256.48615270723;34373;34588.30823383568;29993;30164;30565.694343056286;30873.8456307726;32816;23566.410839729146;23685.407864803517;23856.88071559631;24030.87984560136;24638.507229855662 06:17:36 INFO - PID 17983 | |2;jquery.html;541.1341853035144;552.2048250519251;556.7689408895309;569.8205065404397;573.9225204597378;21174.470638234034;22027.22904698334;22027.779722202773;22030;22106.44733881654;23046;23836.880815595898;24995.75004249957;25006.74993250067;25050.373740656494;6001.2198414206205;6182.659953702545;6186.319504854462;6188.84527886802;6193.69031548423;5977.342492325841;6461.903071453932;6521.869562608745;6522.478201743849;6549.738010479575;6518.478521718251;6518.576292540994;6519.217693876718;6519.771807986722;6520.4131628153455;6534.411902928736;6539.509536784736;6540.607563546178;6544.9345506544805;6546;6024.668643224621;6056.303525094627;6061.454469097803;6066.423689749467;6073.058675905242;29120.271993200127;29352.266193345124;29640.703592964226;30681.539776903363;31792;2047.3448496481133;2088.1751708075226;2092.06902928197;2094.2565389286888;2096.8112869841634;20158.899205504025;20315.288964886306;20674.896625516925;20717.378478645664;21003.474913127142;2500.4249022724694;2526.9765744873357;2578.987105064463;2647.5896236083436;2650.6024096385504;131036;134054;134275.32862335627;134460.32769836186;135061;19810;21146.421739760364;21786.782132178792;21962.670559941613;22055.58138488537;41719.582804172176;41853.372199417034;41879.79060104741;41887.790561047;41891.37162942559;10964.671059868217;11018.173636977099;11107.611233606785;11129.721756956142;11216.831747523795;9213.309001824757;9228.8615670765;9293.628254869729;9320.95339523298;9390.389624674373;8775.648974040967;8872.157145071207;8966;9253.67612133572;11070.833937490945;2664.254008877517;2674.665666791651;2680.6596701649173;2680.758731714155;2774.417372351829;946.4132238012477;966.9806603867884;972.1056627902205;982.5038355630361;991.7520619845038;19827.900860495603;19967.400977970683;20230.291939782037;20348.08433620461;20570.485737856674;1022.1209759606733;1040.6409788622914;1043.7599352149048;1046.053321743823;1048.0829274384914;11018.944905275423;11243.887561124448;11248;11304.208705390543;11340.092792576574;418096;419864.8013519826;449833;452235;457405;113751.4312428449;117850;119332;120659;121338;1182.1912473914924;1242.3415589737454;1243.173289762298;1245.265293476853;1250.2248605864422;20265;20850.061747221716;21003.159873604884;21090;21657.783422165576;56927;58577.4142258589;58610.706946465;58797.70601147138;60048;72387;72501;72554;72611.63694181496;73548;14153.787693184404;14757.188354640168;14885.479008234659;14885.92557037208;14896.702065958403;22973.425664358525;23397.298081057597;23519.17682881091;23738.169164079176;23798.64302035436;18556.721649175543;18700.438986830417;18750;18963.620727585647;18994.715079274098;16601.231084638428;16682.249298781342;16849.747253790956;17464;17512.38706645261;18040.2783888643;18791.530211744815;18980.335688250845;19232;19308.517287067934;14102.576922692335;14414.927925360305;14470.855291447371;14500.347484363017;14556.053856499293;17861.464156075337;17929.731054034462;18221.362252321105;18244.726329104808;18376.264949402408 06:17:36 INFO - PID 17983 | |3;mootools.html;1281.1608396500292;1331.6404570765894;1361.2445092973403;1369.28112740811;1370.0204353886975;14440.277986100693;14478.348474318655;15091.773623395631;15096.47162349318;15119.773203401957;15312.234388280569;15458.84541154588;15466.922665386657;15473.92263038686;15501.147436890966;2725.236933658569;2771.030139451196;2774.875130619127;2781.276868014311;2783.596378525113;2589.9223023309237;2690.8654567271656;2779.9722002779918;2786.3730660601304;2788.3029242689327;2679.209633158223;2686.1135825177744;2714.185744276709;2714.24001279642;2717.1169369954846;2700.1224602004427;2708.634334364865;2718.510668079745;2725.8773355199064;2750.7661848742882;2598.9480210395686;2650.112212408845;2677.8928842846262;2690.9461810763673;2691.9865400673066;14596.34316455762;14708.33812478441;14741.926290368587;14746.483873064391;14762.335694893756;7880.724174653859;8149.7147599833725;8157.061937877161;8160.183981601852;8163.183681631849;5182.119039763249;5313.574914006909;5463.2078348639225;5470.480304371118;5471.781128754845;1905.1902941249914;1957.2366776956999;1972.644923913695;1975.140813746025;2017.7376940997576;24709.87645061763;24995.000199991977;25007.874960625082;25018.124365647298;25153.119640812667;6471.611703297817;6551.4103730664465;6700.564463309869;6744.730210791513;6777.525573209927;15229.771553426708;16737.497875063767;16779.748303775454;16784.748228776578;16821.2430440628;7615.048118985127;7815.413843961725;7832.765017049498;7835.882461763078;7859.607019649109;7160.427165826722;7194.460415468756;7218.855622887513;7219.819504512429;7276.235995220532;5014.548690617789;5174.353205849269;5176.430592634807;5180.067587834151;5218.425973142951;1505.4204131409485;1511.51631477926;1514.3488300031092;1529.9541013769606;1541.0753547871188;910.4355299714219;916.1434059154711;923.3813345058827;933.3932943586723;934.5467448287575;7642.503237289669;7670.539767613961;7692.615369231516;7715.884261736079;7773.805654858674;678.3589507914973;693.9410150137194;706.1526168597703;707.1090426063095;711.2318695808515;4351.717138385995;4884.633652476078;5025.824096156617;5266.894662106736;5317.042932272228;20046.799532004785;20408.89795551013;21209.575808483743;21301.124348213103;21302.36092917215;19035.61928761417;20755.169793208406;20916.79083209179;21192.682109768364;21267.255646052316;10923.781524369468;11220.495077721522;11403.201775875776;11522.827157592643;11557.422128893522;8411.495310281403;8496.192861678377;8533.402661813614;8582.82834343322;8615.095414981588;18040.18819153115;18501.90749046246;18517;18577.16402761852;18808.247670093042;18089.638207236047;18239.817601824343;18480.815191848447;18588.163532640792;18663.626727465646;11610.477528511068;12149.453274602487;12222.144449888423;12293.139480236297;12295.077869160028;13559.389827457986;13574.660633484242;13619.523316683868;13848;13855.099418537762;11118.166137539878;11193.608223712132;11202.551897924317;11398.94300528492;11531.308121512737;10873.625440707816;11062.115030797679;11116.44417779124;11190.88809111931;11407.885921140682;9810.509474526389;9889.109980101824;9922.950385248028;9932.155766759906;9944.45305508204;7095.538789978635;7161.85676286461;7180.820479488055;7181.605011724405;7201.603911784902;7143.570387234696;7230.204677485367;7230.74692385764;7232.819179520554;7269.091363579552 06:17:36 INFO - PID 17983 | |4;prototype.html;499.0493110624261;500.01497050809917;526.4077912348607;526.8261473713675;530.7770736290757;6343.587666801666;6351.523635727327;6361.872762544746;6363.204599425066;6412.236634925398;6029.276486821587;6099.878002439948;6158.766647510049;6161.568690191689;6207.317195108534;4939.975300123494;4957.405111386639;4979.30289759434;5002.074616196006;5029.47190544993;4837.153498137812;4982.77577509013;4999.275105109775;4999.925001124986;5004.274380214867;4976.552110310071;4982.17794063979;5000.249962505617;5001.649884508086;5017.297578339036;4955.380577427822;4960.627952903546;4968.776405061744;4974.701517908901;5006.098902197603;4451.666125040602;4465.263231566788;4468.396766436522;4499.6850220484575;4513.119941611387;6146.170267013986;6167.136600875881;6185.721642526097;6187.721552530147;6206.472449841769;5704.77180912763;5715.342735585419;5722.313322401297;5725.599208055438;5732.742026608813;6542.364408897775;6563.3764792344655;6564.80305590833;6580.967095164541;6608.801735947929;4828.782704778293;4842.854714358539;4843.321934929113;4861.052094841507;4869.464358920516;6828.351306625863;6908.896366554506;6939.895901561481;6961.025456436002;6987.8602427951155;4983.476734942851;4995.350604421402;4997.3253610762085;5001.999600079998;5023.648344615842;5051.444341122474;5063.746812659426;5075.746212689351;5078.5175408336145;5098.133317336062;5672.574556908248;5680.176374425685;5703.319439863258;5705.828825135252;5720.599558030981;6430.196225471816;6492.415682588589;6621.635810030398;6622.238442579069;6636.369544893228;1621.8540331370234;1655.329591515414;1671.2145291712875;1728.4555365059966;1728.6542691461757;1151.9712007199887;1177.7879981603223;1201.3572738584814;1214.6295379909213;1217.3304682424632;5632.97183514088;5651.2935883014625;5697.715114244271;5715.257016587901;5796.42035796417;6621.304762999912;6624.840652885726;6650.600963942179;6702.832429189211;6868.553544019623;5761.366249712528;5769.769209231584;5803.274590676166;5837.708114594253;5843.2403787507355;3495.545579074704;3580.3197392495863;3585.4442561403025;3590.8400607465787;3590.8868250842324;6448.871022579522;6565.21217453899;6576.309487503839;6580.76967306142;6657.733690652417;6830.180378354629;6839.863202736017;6867.278935711778;6986.7205311787975;6994.475414343945;6499.512536559682;6500.772472963424;6509.511786616023;6596.373344532261;6596.878530649705;6706;6708;6731.394174524316;6749.886268765795;6768.763093291908;6640.933590664032;6677.198736151693;6711.355717849158;6733.484965882637;6798.626075565891;6557;6565.868682626417;6637.469002479694;6646.404862832788;6655.534112612071;4887.364642596582;4903.77932993009;4913.926291105565;4918.704877707349;4964.379452568429;6463.289038205888;6682.46540276767;6708.953769100472;6777.254502004874;6825.180978282638;6319.3364696706185;6423.550351475352;6524.934750652623;6614.603123812587;6653.467722582085;6481.351864813481;6562.639054852029;6575.408213260829;6580.539362244788;6598.954324159526;6329.30377658448;6349.523785715997;6401;6433.420992110732;6520.902186467301;6354.204150173909;6553.5084868634085;6613.966930165511;6616.735330586916;6651.334866513504;6386.90419643715;6389.456896163692;6410.435825669583;6412.134361861089;6416.935830641633 06:17:36 INFO - PID 17983 | |5;yui.html;845.1379592815325;856.8286342731453;882.1927935938617;883.0771843423622;885.4421714319977;19279.13243904024;19813.603727925434;19890.10494527746;19901.60196796065;21480.462988425257;19626.116824742887;19866.801331986713;19906.900465497652;20012.49968750782;20028;933.1228645073643;950.6957773512479;950.7813202963323;952.49041762657;954.6658669465701;915.4370062411602;952.380952380951;966.7873067925045;967.2697113679162;968.438305782648;1000.5697550053474;1007.7329507680471;1009.5053423822347;1013.2147585621129;1014.2038499777676;987.012987012987;1003.377905698468;1006.1045669354207;1006.4464544500532;1011.0647650922867;726.7129483853848;737.9151397589292;740.1192580828797;743.275306576084;743.4498471131324;19257.61484770311;19568.51078723029;19665.11506982189;19715.80284197154;19753.111110000085;20613.690794638092;20743.170273189055;21012.264570740102;21124.78875211259;21238.36284911455;16446.75329870041;16470;16562.83437165625;16754.4135955241;16764.41324553647;3693.9630603693886;3715.3498137825773;3715.3683873741256;3732.608076151992;3733.7946412947276;126187;128155.35922320328;128269.43461130818;131695;131934;15958;16313.34746610146;16701;16842.915785420995;16917.577060573338;29705.554416683768;29828.552571711443;30050.398992020037;30217.09348719498;30412.69587304143;7686.807829804187;8061;8615.827683446296;9111.726648200565;9319.673811416567;4408.25059739845;4532.524084971096;4540.02389486262;4540.069285796404;4543.45478542577;5027.723475208899;5118.25785261135;5137.640365174402;5154.561862241751;5167.870803229875;1082.2802836114054;1096.1942971915635;1106.9889301106887;1107.6510899066768;1108.3405373802575;690.413148823506;704.6018999265399;706.477206866925;710.8555226085997;712.4514124124395;11957.820632690517;12032.977196938358;12165.69585760363;12206.816897746541;13029.934850325688;693.2686016252902;694.5311914457822;696.4045740891567;704.5772536478072;706.0926709178681;5587.832365028974;5733.3406658234;5843.94156058434;5940.108983652401;6032.788852390146;104129;104961;106165.46917265364;107127;108027.45986270018;92982.53508732413;94240;96668.51665741767;97576.51211743896;100689.49655251676;85704.86562094165;87788.56105719431;89689.55155224183;90033.54983225172;90238;12745.936270318589;12980.870191297967;12998.545050923172;13096.803547946978;13117.73764524685;40044.79977600093;41053.38419923763;41153.38269925894;41575;42306.576934231496;52029.479705202466;52652;52705.736471317396;53060.73469632627;54632;17227.741583876003;17552.648947021244;17689;17738.645227095127;17769.111544422987;19919.502012449804;19932.20271189136;19981.400557983285;20193.6970945433;20462.693059603822;18183.18175682071;18186.181621827312;18192.272309107488;18216.089195539906;18439.53901152482;17975.640487190445;18005.189766460804;18009.189586468903;18310.725339120192;18362.08189590542;16757.74863377075;17032.48902532926;17042.65914681724;17056.57358566046;17240.482785516455;13418.987151926898;13778.311084445939;13792.655183620089;13878.375473103533;13981.720365592835;13968.930155349159;14033.3684984178;14168.433262669378;14187.290635467978;14273.143611382935 06:17:36 INFO - PID 17983 | __end_tp_report 06:17:36 INFO - PID 17983 | __start_cc_report 06:17:36 INFO - PID 17983 | _x_x_mozilla_cycle_collect,366 06:17:36 INFO - PID 17983 | __end_cc_report 06:17:36 INFO - PID 17983 | __startTimestamp1503580656461__endTimestamp 06:17:36 INFO - PID 17983 | 06:17:36 INFO - PID 17983 | ------- Summary: start ------- 06:17:36 INFO - PID 17983 | Number of tests: 6 06:17:36 INFO - PID 17983 | 06:17:36 INFO - PID 17983 | [#0] dojo.html Cycles:165 Average:6091.13 Median:6388.43 stddev:810.18 (12.7%) stddev-sans-first:781.47 06:17:36 INFO - PID 17983 | Values: 3253.2 3279.4 3282.4 3284.3 3331.1 6139.3 6184.0 6221.0 6229.8 6247.1 6083.5 6214.7 6217.5 6331.2 6340.8 5696.3 5756.7 5775.0 5794.9 5808.9 918.5 5506.2 5653.6 5702.5 5817.9 5690.4 5710.5 5746.3 5782.5 5786.1 5642.4 5658.4 5699.2 5719.3 5725.7 5679.3 5742.7 5755.0 5779.0 5781.7 6083.9 6154.2 6192.7 6201.8 6253.4 6574.5 6581.2 6619.6 6626.2 6626.9 6586.4 6680.4 6680.5 6696.1 6696.8 6133.0 6187.5 6190.8 6191.4 6201.4 6909.4 6928.3 6936.7 6943.1 6965.8 6558.4 6565.1 6650.0 6655.1 6666.2 6543.8 6676.2 6684.3 6767.1 6768.6 6550.4 6551.1 6554.4 6555.0 6563.9 5824.4 6580.9 6589.4 6590.4 6593.9 5229.8 5242.1 5296.9 5298.3 5299.8 4506.6 4583.8 4608.4 4617.7 4648.7 5734.3 5738.7 5756.7 5767.2 5778.8 6696.5 6696.8 6716.9 6719.9 6725.8 5781.5 5784.0 5824.6 5864.1 5865.1 5735.3 5738.8 5802.5 5812.0 5823.6 6369.8 6500.2 6505.4 6506.4 6602.7 6529.1 6556.8 6566.0 6696.3 6711.1 6346.2 6424.2 6428.0 6433.8 6467.3 6417.2 6426.4 6506.6 6515.8 6536.6 6555.0 6560.5 6581.5 6656.3 6658.3 6385.6 6418.6 6430.4 6434.2 6434.4 6356.8 6412.0 6438.4 6446.1 6450.9 6439.1 6452.4 6457.1 6460.7 6468.7 6450.4 6566.9 6566.9 6599.5 6605.2 6296.7 6302.4 6315.5 6388.4 6408.3 06:17:36 INFO - PID 17983 | 06:17:36 INFO - PID 17983 | [#1] ext.html Cycles:180 Average:36277.59 Median:19044.46 stddev:51848.77 (272.3%) stddev-sans-first:51925.65 06:17:36 INFO - PID 17983 | Values: 763.2 832.1 843.9 866.5 874.5 38858.0 39558.4 39631.0 39675.4 39715.6 35955.1 36101.5 36170.5 36193.1 36405.3 6767.2 6818.9 6821.4 6947.3 6959.6 7334.2 7502.8 7561.3 7561.8 7562.7 7546.4 7555.2 7599.6 7607.5 7609.0 7283.7 7521.2 7542.2 7551.4 7572.3 7381.9 7426.5 7440.4 7451.3 7455.8 35388.8 35644.3 35663.6 35666.1 35714.3 3500.6 3533.2 3533.9 3535.3 3537.9 30255.4 30361.8 30408.4 30429.4 30478.2 4874.6 4945.7 4950.8 5025.3 5044.5 173249.0 174316.0 174844.0 176289.0 176422.0 45568.5 45621.2 45778.3 45864.0 45977.3 47459.3 47830.8 47853.5 48098.5 48213.0 15407.6 15694.3 15729.6 15744.8 15774.9 13005.7 13006.2 13008.9 13011.3 13052.3 13912.0 13927.9 13940.3 14084.2 14146.0 5433.4 5433.5 5460.6 5484.5 5558.5 983.9 985.1 988.5 993.2 1003.2 21684.8 21922.1 22022.9 22082.1 22490.1 1073.2 1090.3 1093.6 1094.6 1104.7 11454.2 11845.8 11918.5 11941.2 12023.9 224541.0 226294.0 227296.0 227435.0 227599.0 44777.0 44909.6 53199.2 53720.7 54079.7 1433.9 1439.5 1444.2 1452.5 1455.8 26842.6 26970.5 27019.3 27109.9 27297.6 37187.8 37421.8 37500.2 37507.8 37525.8 194426.0 195370.0 196080.0 196169.0 198039.0 32981.7 34178.8 34262.0 34272.5 34552.0 41188.2 41389.2 41409.4 41462.8 41645.0 30577.4 30579.0 30792.2 30943.5 31222.8 30877.8 31211.7 31337.4 31344.7 31654.8 33579.3 34236.8 34256.5 34373.0 34588.3 29993.0 30164.0 30565.7 30873.8 32816.0 23566.4 23685.4 23856.9 24030.9 24638.5 06:17:36 INFO - PID 17983 | 06:17:36 INFO - PID 17983 | [#2] jquery.html Cycles:180 Average:34270.28 Median:22539.94 stddev:74791.67 (331.8%) stddev-sans-first:74958.60 06:17:36 INFO - PID 17983 | Values: 541.1 552.2 556.8 569.8 573.9 21174.5 22027.2 22027.8 22030.0 22106.4 23046.0 23836.9 24995.8 25006.7 25050.4 6001.2 6182.7 6186.3 6188.8 6193.7 5977.3 6461.9 6521.9 6522.5 6549.7 6518.5 6518.6 6519.2 6519.8 6520.4 6534.4 6539.5 6540.6 6544.9 6546.0 6024.7 6056.3 6061.5 6066.4 6073.1 29120.3 29352.3 29640.7 30681.5 31792.0 2047.3 2088.2 2092.1 2094.3 2096.8 20158.9 20315.3 20674.9 20717.4 21003.5 2500.4 2527.0 2579.0 2647.6 2650.6 131036.0 134054.0 134275.3 134460.3 135061.0 19810.0 21146.4 21786.8 21962.7 22055.6 41719.6 41853.4 41879.8 41887.8 41891.4 10964.7 11018.2 11107.6 11129.7 11216.8 9213.3 9228.9 9293.6 9321.0 9390.4 8775.6 8872.2 8966.0 9253.7 11070.8 2664.3 2674.7 2680.7 2680.8 2774.4 946.4 967.0 972.1 982.5 991.8 19827.9 19967.4 20230.3 20348.1 20570.5 1022.1 1040.6 1043.8 1046.1 1048.1 11018.9 11243.9 11248.0 11304.2 11340.1 418096.0 419864.8 449833.0 452235.0 457405.0 113751.4 117850.0 119332.0 120659.0 121338.0 1182.2 1242.3 1243.2 1245.3 1250.2 20265.0 20850.1 21003.2 21090.0 21657.8 56927.0 58577.4 58610.7 58797.7 60048.0 72387.0 72501.0 72554.0 72611.6 73548.0 14153.8 14757.2 14885.5 14885.9 14896.7 22973.4 23397.3 23519.2 23738.2 23798.6 18556.7 18700.4 18750.0 18963.6 18994.7 16601.2 16682.2 16849.7 17464.0 17512.4 18040.3 18791.5 18980.3 19232.0 19308.5 14102.6 14414.9 14470.9 14500.3 14556.1 17861.5 17929.7 18221.4 18244.7 18376.3 06:17:36 INFO - PID 17983 | 06:17:36 INFO - PID 17983 | [#3] mootools.html Cycles:180 Average:9171.87 Median:2688.49 stddev:6433.31 (239.3%) stddev-sans-first:6424.04 06:17:36 INFO - PID 17983 | Values: 1281.2 1331.6 1361.2 1369.3 1370.0 14440.3 14478.3 15091.8 15096.5 15119.8 15312.2 15458.8 15466.9 15473.9 15501.1 2725.2 2771.0 2774.9 2781.3 2783.6 2589.9 2690.9 2780.0 2786.4 2788.3 2679.2 2686.1 2714.2 2714.2 2717.1 2700.1 2708.6 2718.5 2725.9 2750.8 2598.9 2650.1 2677.9 2690.9 2692.0 14596.3 14708.3 14741.9 14746.5 14762.3 7880.7 8149.7 8157.1 8160.2 8163.2 5182.1 5313.6 5463.2 5470.5 5471.8 1905.2 1957.2 1972.6 1975.1 2017.7 24709.9 24995.0 25007.9 25018.1 25153.1 6471.6 6551.4 6700.6 6744.7 6777.5 15229.8 16737.5 16779.7 16784.7 16821.2 7615.0 7815.4 7832.8 7835.9 7859.6 7160.4 7194.5 7218.9 7219.8 7276.2 5014.5 5174.4 5176.4 5180.1 5218.4 1505.4 1511.5 1514.3 1530.0 1541.1 910.4 916.1 923.4 933.4 934.5 7642.5 7670.5 7692.6 7715.9 7773.8 678.4 693.9 706.2 707.1 711.2 4351.7 4884.6 5025.8 5266.9 5317.0 20046.8 20408.9 21209.6 21301.1 21302.4 19035.6 20755.2 20916.8 21192.7 21267.3 10923.8 11220.5 11403.2 11522.8 11557.4 8411.5 8496.2 8533.4 8582.8 8615.1 18040.2 18501.9 18517.0 18577.2 18808.2 18089.6 18239.8 18480.8 18588.2 18663.6 11610.5 12149.5 12222.1 12293.1 12295.1 13559.4 13574.7 13619.5 13848.0 13855.1 11118.2 11193.6 11202.6 11398.9 11531.3 10873.6 11062.1 11116.4 11190.9 11407.9 9810.5 9889.1 9923.0 9932.2 9944.5 7095.5 7161.9 7180.8 7181.6 7201.6 7143.6 7230.2 7230.7 7232.8 7269.1 06:17:36 INFO - PID 17983 | 06:17:36 INFO - PID 17983 | [#4] prototype.html Cycles:180 Average:5520.41 Median:6176.43 stddev:1562.52 (25.3%) stddev-sans-first:1520.77 06:17:36 INFO - PID 17983 | Values: 499.0 500.0 526.4 526.8 530.8 6343.6 6351.5 6361.9 6363.2 6412.2 6029.3 6099.9 6158.8 6161.6 6207.3 4940.0 4957.4 4979.3 5002.1 5029.5 4837.2 4982.8 4999.3 4999.9 5004.3 4976.6 4982.2 5000.2 5001.6 5017.3 4955.4 4960.6 4968.8 4974.7 5006.1 4451.7 4465.3 4468.4 4499.7 4513.1 6146.2 6167.1 6185.7 6187.7 6206.5 5704.8 5715.3 5722.3 5725.6 5732.7 6542.4 6563.4 6564.8 6581.0 6608.8 4828.8 4842.9 4843.3 4861.1 4869.5 6828.4 6908.9 6939.9 6961.0 6987.9 4983.5 4995.4 4997.3 5002.0 5023.6 5051.4 5063.7 5075.7 5078.5 5098.1 5672.6 5680.2 5703.3 5705.8 5720.6 6430.2 6492.4 6621.6 6622.2 6636.4 1621.9 1655.3 1671.2 1728.5 1728.7 1152.0 1177.8 1201.4 1214.6 1217.3 5633.0 5651.3 5697.7 5715.3 5796.4 6621.3 6624.8 6650.6 6702.8 6868.6 5761.4 5769.8 5803.3 5837.7 5843.2 3495.5 3580.3 3585.4 3590.8 3590.9 6448.9 6565.2 6576.3 6580.8 6657.7 6830.2 6839.9 6867.3 6986.7 6994.5 6499.5 6500.8 6509.5 6596.4 6596.9 6706.0 6708.0 6731.4 6749.9 6768.8 6640.9 6677.2 6711.4 6733.5 6798.6 6557.0 6565.9 6637.5 6646.4 6655.5 4887.4 4903.8 4913.9 4918.7 4964.4 6463.3 6682.5 6709.0 6777.3 6825.2 6319.3 6423.6 6524.9 6614.6 6653.5 6481.4 6562.6 6575.4 6580.5 6599.0 6329.3 6349.5 6401.0 6433.4 6520.9 6354.2 6553.5 6614.0 6616.7 6651.3 6386.9 6389.5 6410.4 6412.1 6416.9 06:17:36 INFO - PID 17983 | 06:17:36 INFO - PID 17983 | [#5] yui.html Cycles:180 Average:23289.12 Median:20020.25 stddev:31600.60 (157.8%) stddev-sans-first:31644.31 06:17:36 INFO - PID 17983 | Values: 845.1 856.8 882.2 883.1 885.4 19279.1 19813.6 19890.1 19901.6 21480.5 19626.1 19866.8 19906.9 20012.5 20028.0 933.1 950.7 950.8 952.5 954.7 915.4 952.4 966.8 967.3 968.4 1000.6 1007.7 1009.5 1013.2 1014.2 987.0 1003.4 1006.1 1006.4 1011.1 726.7 737.9 740.1 743.3 743.4 19257.6 19568.5 19665.1 19715.8 19753.1 20613.7 20743.2 21012.3 21124.8 21238.4 16446.8 16470.0 16562.8 16754.4 16764.4 3694.0 3715.3 3715.4 3732.6 3733.8 126187.0 128155.4 128269.4 131695.0 131934.0 15958.0 16313.3 16701.0 16842.9 16917.6 29705.6 29828.6 30050.4 30217.1 30412.7 7686.8 8061.0 8615.8 9111.7 9319.7 4408.3 4532.5 4540.0 4540.1 4543.5 5027.7 5118.3 5137.6 5154.6 5167.9 1082.3 1096.2 1107.0 1107.7 1108.3 690.4 704.6 706.5 710.9 712.5 11957.8 12033.0 12165.7 12206.8 13029.9 693.3 694.5 696.4 704.6 706.1 5587.8 5733.3 5843.9 5940.1 6032.8 104129.0 104961.0 106165.5 107127.0 108027.5 92982.5 94240.0 96668.5 97576.5 100689.5 85704.9 87788.6 89689.6 90033.5 90238.0 12745.9 12980.9 12998.5 13096.8 13117.7 40044.8 41053.4 41153.4 41575.0 42306.6 52029.5 52652.0 52705.7 53060.7 54632.0 17227.7 17552.6 17689.0 17738.6 17769.1 19919.5 19932.2 19981.4 20193.7 20462.7 18183.2 18186.2 18192.3 18216.1 18439.5 17975.6 18005.2 18009.2 18310.7 18362.1 16757.7 17032.5 17042.7 17056.6 17240.5 13419.0 13778.3 13792.7 13878.4 13981.7 13968.9 14033.4 14168.4 14187.3 14273.1 06:17:36 INFO - PID 17983 | -------- Summary: end -------- 06:17:36 INFO - PID 17983 | 06:17:37 INFO - TEST-INFO | 17983: exit 0 06:17:37 INFO - TEST-OK | dromaeo_css | took 1111207ms 06:17:37 INFO - TEST-START | kraken 06:17:37 INFO - Initialising browser for kraken test... 06:17:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51188/getInfo.html -profile /tmp/tmpWkHrOb/profile 06:17:37 INFO - TEST-INFO | started process 18414 (/builds/slave/test/build/application/firefox/firefox http://localhost:51188/getInfo.html) 06:17:43 INFO - TEST-INFO | 18414: exit 0 06:17:43 INFO - Browser initialized. 06:17:43 INFO - Running cycle 1/1 for kraken test... 06:17:43 INFO - TEST-INFO | started process 18599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWkHrOb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:44 INFO - PID 18599 | 06:17:44 INFO - PID 18599 | (/builds/slave/test/build/application/firefox/firefox:18649): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:17:44 INFO - PID 18599 | 06:17:44 INFO - PID 18599 | 06:17:44 INFO - PID 18599 | (/builds/slave/test/build/application/firefox/firefox:18711): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:17:44 INFO - PID 18599 | 06:17:44 INFO - PID 18599 | __metrics Screen width/height:1600/1200 06:17:44 INFO - PID 18599 | colorDepth:24 06:17:44 INFO - PID 18599 | Browser inner width/height: 1024/768 06:17:44 INFO - PID 18599 | __metrics 06:17:54 INFO - PID 18599 | RSS: Main: 175169536 06:17:54 INFO - PID 18599 | 06:17:57 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51188/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:58 INFO - PID 18599 | RSS: Main: 179232768 06:17:58 INFO - PID 18599 | 06:18:00 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51188/tests/kraken/driver.html?testName=audio-dft) 06:18:01 INFO - PID 18599 | RSS: Main: 181166080 06:18:01 INFO - PID 18599 | 06:18:04 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51188/tests/kraken/driver.html?testName=audio-fft) 06:18:05 INFO - PID 18599 | RSS: Main: 174661632 06:18:05 INFO - PID 18599 | 06:18:07 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51188/tests/kraken/driver.html?testName=audio-oscillator) 06:18:08 INFO - PID 18599 | RSS: Main: 175448064 06:18:08 INFO - PID 18599 | 06:18:10 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51188/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:10 INFO - PID 18599 | RSS: Main: 175570944 06:18:10 INFO - PID 18599 | 06:18:14 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51188/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:14 INFO - PID 18599 | RSS: Main: 176427008 06:18:14 INFO - PID 18599 | 06:18:18 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51188/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:18 INFO - PID 18599 | RSS: Main: 176812032 06:18:18 INFO - PID 18599 | 06:18:21 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51188/tests/kraken/driver.html?testName=json-parse-financial) 06:18:22 INFO - PID 18599 | RSS: Main: 177201152 06:18:22 INFO - PID 18599 | 06:18:24 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51188/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:24 INFO - PID 18599 | RSS: Main: 176984064 06:18:24 INFO - PID 18599 | 06:18:26 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51188/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:27 INFO - PID 18599 | RSS: Main: 176742400 06:18:27 INFO - PID 18599 | 06:18:29 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51188/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:30 INFO - PID 18599 | RSS: Main: 177082368 06:18:30 INFO - PID 18599 | 06:18:32 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:33 INFO - PID 18599 | RSS: Main: 177680384 06:18:33 INFO - PID 18599 | 06:18:36 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:37 INFO - PID 18599 | RSS: Main: 177635328 06:18:37 INFO - PID 18599 | 06:18:38 INFO - PID 18599 | Cycle 1(1): loaded http://localhost:51188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51188/tests/kraken/driver.html?testName=ai-astar) 06:18:39 INFO - PID 18599 | RSS: Main: 178991104 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | __start_tp_report 06:18:39 INFO - PID 18599 | _x_x_mozilla_page_load 06:18:39 INFO - PID 18599 | _x_x_mozilla_page_load_details 06:18:39 INFO - PID 18599 | |i|pagename|runs| 06:18:39 INFO - PID 18599 | |0;ai-astar;102;107;96;108;108;108;113;109;109;109 06:18:39 INFO - PID 18599 | |1;audio-beat-detection;150;122;145;196;117;149;144;118;177;120 06:18:39 INFO - PID 18599 | |2;audio-dft;169;161;162;161;164;180;166;161;160;170 06:18:39 INFO - PID 18599 | |3;audio-fft;74;75;74;172;75;77;73;73;150;75 06:18:39 INFO - PID 18599 | |4;audio-oscillator;79;79;133;83;81;78;125;82;78;140 06:18:39 INFO - PID 18599 | |5;imaging-gaussian-blur;118;114;114;115;113;120;122;114;121;114 06:18:39 INFO - PID 18599 | |6;imaging-darkroom;149;149;149;147;151;149;149;148;147;150 06:18:39 INFO - PID 18599 | |7;imaging-desaturate;93;94;95;99;99;94;93;94;93;93 06:18:39 INFO - PID 18599 | |8;json-parse-financial;56;53;52;59;54;54;53;58;53;52 06:18:39 INFO - PID 18599 | |9;json-stringify-tinderbox;61;54;55;55;56;55;54;60;60;63 06:18:39 INFO - PID 18599 | |10;stanford-crypto-aes;88;80;75;84;81;74;78;87;79;75 06:18:39 INFO - PID 18599 | |11;stanford-crypto-ccm;123;126;122;117;117;119;118;126;118;153 06:18:39 INFO - PID 18599 | |12;stanford-crypto-pbkdf2;171;179;170;182;174;171;170;178;171;167 06:18:39 INFO - PID 18599 | |13;stanford-crypto-sha256-iterative;73;73;64;64;66;63;63;65;69;74 06:18:39 INFO - PID 18599 | __end_tp_report 06:18:39 INFO - PID 18599 | __start_cc_report 06:18:39 INFO - PID 18599 | _x_x_mozilla_cycle_collect,983 06:18:39 INFO - PID 18599 | __end_cc_report 06:18:39 INFO - PID 18599 | __startTimestamp1503580719210__endTimestamp 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | ------- Summary: start ------- 06:18:39 INFO - PID 18599 | Number of tests: 14 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#0] ai-astar Cycles:10 Average:106.90 Median:109.00 stddev:4.68 (4.3%) stddev-sans-first:4.61 06:18:39 INFO - PID 18599 | Values: 102.0 107.0 96.0 108.0 108.0 108.0 113.0 109.0 109.0 109.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:147.00 stddev:26.50 (18.0%) stddev-sans-first:28.01 06:18:39 INFO - PID 18599 | Values: 150.0 122.0 145.0 196.0 117.0 149.0 144.0 118.0 177.0 120.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:6.22 (3.8%) stddev-sans-first:6.46 06:18:39 INFO - PID 18599 | Values: 169.0 161.0 162.0 161.0 164.0 180.0 166.0 161.0 160.0 170.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#3] audio-fft Cycles:10 Average:91.80 Median:74.50 stddev:36.86 (49.5%) stddev-sans-first:38.53 06:18:39 INFO - PID 18599 | Values: 74.0 75.0 74.0 172.0 75.0 77.0 73.0 73.0 150.0 75.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:79.00 stddev:25.74 (32.6%) stddev-sans-first:26.57 06:18:39 INFO - PID 18599 | Values: 79.0 79.0 133.0 83.0 81.0 78.0 125.0 82.0 78.0 140.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:3.41 (2.9%) stddev-sans-first:3.57 06:18:39 INFO - PID 18599 | Values: 118.0 114.0 114.0 115.0 113.0 120.0 122.0 114.0 121.0 114.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 06:18:39 INFO - PID 18599 | Values: 149.0 149.0 149.0 147.0 151.0 149.0 149.0 148.0 147.0 150.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:2.36 (2.5%) stddev-sans-first:2.42 06:18:39 INFO - PID 18599 | Values: 93.0 94.0 95.0 99.0 99.0 94.0 93.0 94.0 93.0 93.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:2.46 (4.6%) stddev-sans-first:2.54 06:18:39 INFO - PID 18599 | Values: 56.0 53.0 52.0 59.0 54.0 54.0 53.0 58.0 53.0 52.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:58.00 stddev:3.33 (5.7%) stddev-sans-first:3.26 06:18:39 INFO - PID 18599 | Values: 61.0 54.0 55.0 55.0 56.0 55.0 54.0 60.0 60.0 63.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.50 stddev:4.95 (6.2%) stddev-sans-first:4.35 06:18:39 INFO - PID 18599 | Values: 88.0 80.0 75.0 84.0 81.0 74.0 78.0 87.0 79.0 75.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:122.50 stddev:10.80 (8.8%) stddev-sans-first:11.45 06:18:39 INFO - PID 18599 | Values: 123.0 126.0 122.0 117.0 117.0 119.0 118.0 126.0 118.0 153.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:172.50 stddev:4.81 (2.8%) stddev-sans-first:5.03 06:18:39 INFO - PID 18599 | Values: 171.0 179.0 170.0 182.0 174.0 171.0 170.0 178.0 171.0 167.0 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:4.45 (6.6%) stddev-sans-first:4.24 06:18:39 INFO - PID 18599 | Values: 73.0 73.0 64.0 64.0 66.0 63.0 63.0 65.0 69.0 74.0 06:18:39 INFO - PID 18599 | -------- Summary: end -------- 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 06:18:39 INFO - PID 18599 | 06:18:39 INFO - PID 18599 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:18:39 INFO - TEST-INFO | 18599: exit 0 06:18:39 INFO - TEST-OK | kraken | took 62639ms 06:18:39 INFO - SUITE-END | took 1173s 06:18:40 INFO - Completed test suite (00:19:34) 06:18:40 INFO - javascript benchmark 06:18:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8491.246063033317, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3253.1704415374074, 3279.3769183855075, 3282.392757339891, 3284.310294838084, 3331.1172539277095, 6139.293981192164, 6183.9690801545985, 6221.0, 6229.781957631484, 6247.125402443661, 6083.543734219929, 6214.65819379934, 6217.5025997920175, 6331.240251169855, 6340.809775706736, 5696.259486266779, 5756.740946657411, 5774.971125144369, 5794.942050579482, 5808.883822323551, 918.4791908503558, 5506.174073888928, 5653.632513886584, 5702.45826646468, 5817.854553636172, 5690.374058853523, 5710.514606258453, 5746.339170995327, 5782.45066718661, 5786.103154011135, 5642.351129620064, 5658.43415658435, 5699.202111704365, 5719.3422756382715, 5725.656460612335, 5679.290088738908, 5742.655440673573, 5754.97122514389, 5779.0, 5781.710914454303, 6083.9391606084255, 6154.169187159721, 6192.721327540272, 6201.751929922798, 6253.405926436982, 6574.539782215247, 6581.177352830896, 6619.569727967715, 6626.2048554173325, 6626.86746265072, 6586.37429444202, 6680.432163266129, 6680.498962577777, 6696.129503164558, 6696.799096027127, 6133.049377346474, 6187.535934804908, 6190.752369905198, 6191.380861913818, 6201.441870231701, 6909.378155965987, 6928.307169283132, 6936.653167341613, 6943.132108486439, 6965.825854353681, 6558.442532384705, 6565.146530950946, 6650.0, 6655.101561289261, 6666.233383160901, 6543.770968016192, 6676.232233293234, 6684.2647308795995, 6767.086443330186, 6768.56004359715, 6550.410463058348, 6551.1155993941165, 6554.442872355808, 6555.016747487915, 6563.868722625521, 5824.417558244227, 6580.901286480706, 6589.374009469093, 6590.373914478117, 6593.86812263752, 5229.790808367698, 5242.082635538765, 5296.894062118813, 5298.311219541435, 5299.8410047698635, 4506.639468842484, 4583.839565615188, 4608.400907882021, 4617.653675974316, 4648.7443190624845, 5734.340550836707, 5738.741756620962, 5756.683382413924, 5767.192593036978, 5778.797742079007, 6696.46428285736, 6696.799096027127, 6716.865662686719, 6719.865602687919, 6725.764598239038, 5781.4507621775865, 5784.0, 5824.563157763185, 5864.120381942657, 5865.149553314745, 5735.340435849931, 5738.8278351649515, 5802.535797136304, 5812.041013232853, 5823.592348535646, 6369.840753981188, 6500.187476565429, 6505.41451269388, 6506.3818937200895, 6602.669866506655, 6529.11856899322, 6556.770513032021, 6566.0, 6696.263411024686, 6711.0940023096255, 6346.2067241594805, 6424.164858568356, 6428.003659432796, 6433.839154021, 6467.320931302145, 6417.1657684500715, 6426.389492998158, 6506.577072490273, 6515.771947981987, 6536.575122617015, 6555.049517819984, 6560.475161986934, 6581.473482121323, 6656.30108838565, 6658.300878407697, 6385.553011289351, 6418.55070145104, 6430.421262086435, 6434.227892652912, 6434.356564343529, 6356.77751278703, 6411.96794016027, 6438.356164383524, 6446.09754634361, 6450.903236451363, 6439.130717353098, 6452.387023232785, 6457.128287681291, 6460.741570337133, 6468.741250349934, 6450.41946224842, 6566.868662626625, 6566.883629782853, 6599.505037122139, 6605.174353205849, 6296.716647750954, 6302.401271879165, 6315.5263355247625, 6388.425041746079, 6408.263049749152], "value": 6036.281872412226, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.1910175214273, 832.1428928203952, 843.8860753798238, 866.5493943149562, 874.5321253129573, 38858.0, 39558.406623900664, 39631.00922476936, 39675.40486892692, 39715.60284397155, 35955.10112247195, 36101.45847812278, 36170.45744313837, 36193.0951726207, 36405.27189456216, 6767.187937447513, 6818.897716534256, 6821.351971562718, 6947.340002699761, 6959.61722105284, 7334.193238743734, 7502.774916752479, 7561.319481246686, 7561.773146805577, 7562.735304264352, 7546.396288296923, 7555.168931417567, 7599.620018999056, 7607.505512141721, 7609.0, 7283.745068922589, 7521.172671006212, 7542.170361260257, 7551.433642476809, 7572.318491335806, 7381.88927166093, 7426.517276377018, 7440.404767618577, 7451.2921272479025, 7455.813604659873, 35388.823055884815, 35644.28711425783, 35663.64336356629, 35666.108347291265, 35714.28571428557, 3500.6149323574386, 3533.152043509565, 3533.9116522086897, 3535.3106144301873, 3537.9469307960403, 30255.394892102035, 30361.848190758905, 30408.391832163234, 30429.391412171855, 30478.238044048856, 4874.634402419832, 4945.727984960826, 4950.801967921278, 5025.296458495814, 5044.495550444926, 173249.0, 174316.0, 174844.0, 176289.0, 176422.0, 45568.54431455709, 45621.175152994176, 45778.31332530015, 45864.0, 45977.31034034492, 47459.28811067837, 47830.760846196245, 47853.521464784906, 48098.519014809404, 48213.0, 15407.61480962985, 15694.293756780973, 15729.606759831096, 15744.763828542582, 15774.921125394529, 13005.674858128434, 13006.219626822232, 13008.869911300955, 13011.349432528335, 13052.34738263083, 13912.0, 13927.930360348337, 13940.302984850718, 14084.15495070299, 14146.0, 5433.429489903582, 5433.538149257357, 5460.590455715837, 5484.478974497496, 5558.527525160326, 983.9458829764432, 985.1084768284713, 988.4563490080427, 993.2103977337889, 1003.247564326755, 21684.783152168275, 21922.123115075537, 22022.88988555047, 22082.11671533153, 22490.100395984304, 1073.1575713065206, 1090.3294473898654, 1093.5899037860802, 1094.5676457799125, 1104.718296834302, 11454.198206125491, 11845.822312665317, 11918.523259069714, 11941.223820451643, 12023.857733515302, 224541.0, 226294.0, 227296.0, 227435.0, 227599.0, 44777.0, 44909.55090449119, 53199.20201196985, 53720.731396342766, 54079.72960135253, 1433.8781203597812, 1439.4817865568386, 1444.169602478579, 1452.5206681794982, 1455.7889106079558, 26842.620527062678, 26970.460590788465, 27019.32451688645, 27109.86445067762, 27297.590536141575, 37187.81406092952, 37421.81289093537, 37500.24999500049, 37507.81246093752, 37525.81237093797, 194426.0, 195370.0, 196080.0, 196169.0, 198039.0, 32981.67018329786, 34178.82910585431, 34262.0, 34272.485912711825, 34552.0, 41188.1762364757, 41389.1722165561, 41409.37885931653, 41462.79268603758, 41645.0, 30577.388452230385, 30579.0, 30792.23019424443, 30943.535846962764, 31222.843885780425, 30877.8456107718, 31211.687883120878, 31337.37325253528, 31344.686553134175, 31654.841725791222, 33579.328413432086, 34236.82881585676, 34256.48615270723, 34373.0, 34588.30823383568, 29993.0, 30164.0, 30565.694343056286, 30873.8456307726, 32816.0, 23566.410839729146, 23685.407864803517, 23856.88071559631, 24030.87984560136, 24638.507229855662], "value": 16651.481156882954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.1341853035144, 552.2048250519251, 556.7689408895309, 569.8205065404397, 573.9225204597378, 21174.470638234034, 22027.22904698334, 22027.779722202773, 22030.0, 22106.44733881654, 23046.0, 23836.880815595898, 24995.75004249957, 25006.74993250067, 25050.373740656494, 6001.2198414206205, 6182.659953702545, 6186.319504854462, 6188.84527886802, 6193.69031548423, 5977.342492325841, 6461.903071453932, 6521.869562608745, 6522.478201743849, 6549.738010479575, 6518.478521718251, 6518.576292540994, 6519.217693876718, 6519.771807986722, 6520.4131628153455, 6534.411902928736, 6539.509536784736, 6540.607563546178, 6544.9345506544805, 6546.0, 6024.668643224621, 6056.303525094627, 6061.454469097803, 6066.423689749467, 6073.058675905242, 29120.271993200127, 29352.266193345124, 29640.703592964226, 30681.539776903363, 31792.0, 2047.3448496481133, 2088.1751708075226, 2092.06902928197, 2094.2565389286888, 2096.8112869841634, 20158.899205504025, 20315.288964886306, 20674.896625516925, 20717.378478645664, 21003.474913127142, 2500.4249022724694, 2526.9765744873357, 2578.987105064463, 2647.5896236083436, 2650.6024096385504, 131036.0, 134054.0, 134275.32862335627, 134460.32769836186, 135061.0, 19810.0, 21146.421739760364, 21786.782132178792, 21962.670559941613, 22055.58138488537, 41719.582804172176, 41853.372199417034, 41879.79060104741, 41887.790561047, 41891.37162942559, 10964.671059868217, 11018.173636977099, 11107.611233606785, 11129.721756956142, 11216.831747523795, 9213.309001824757, 9228.8615670765, 9293.628254869729, 9320.95339523298, 9390.389624674373, 8775.648974040967, 8872.157145071207, 8966.0, 9253.67612133572, 11070.833937490945, 2664.254008877517, 2674.665666791651, 2680.6596701649173, 2680.758731714155, 2774.417372351829, 946.4132238012477, 966.9806603867884, 972.1056627902205, 982.5038355630361, 991.7520619845038, 19827.900860495603, 19967.400977970683, 20230.291939782037, 20348.08433620461, 20570.485737856674, 1022.1209759606733, 1040.6409788622914, 1043.7599352149048, 1046.053321743823, 1048.0829274384914, 11018.944905275423, 11243.887561124448, 11248.0, 11304.208705390543, 11340.092792576574, 418096.0, 419864.8013519826, 449833.0, 452235.0, 457405.0, 113751.4312428449, 117850.0, 119332.0, 120659.0, 121338.0, 1182.1912473914924, 1242.3415589737454, 1243.173289762298, 1245.265293476853, 1250.2248605864422, 20265.0, 20850.061747221716, 21003.159873604884, 21090.0, 21657.783422165576, 56927.0, 58577.4142258589, 58610.706946465, 58797.70601147138, 60048.0, 72387.0, 72501.0, 72554.0, 72611.63694181496, 73548.0, 14153.787693184404, 14757.188354640168, 14885.479008234659, 14885.92557037208, 14896.702065958403, 22973.425664358525, 23397.298081057597, 23519.17682881091, 23738.169164079176, 23798.64302035436, 18556.721649175543, 18700.438986830417, 18750.0, 18963.620727585647, 18994.715079274098, 16601.231084638428, 16682.249298781342, 16849.747253790956, 17464.0, 17512.38706645261, 18040.2783888643, 18791.530211744815, 18980.335688250845, 19232.0, 19308.517287067934, 14102.576922692335, 14414.927925360305, 14470.855291447371, 14500.347484363017, 14556.053856499293, 17861.464156075337, 17929.731054034462, 18221.362252321105, 18244.726329104808, 18376.264949402408], "value": 12394.120775983356, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.1608396500292, 1331.6404570765894, 1361.2445092973403, 1369.28112740811, 1370.0204353886975, 14440.277986100693, 14478.348474318655, 15091.773623395631, 15096.47162349318, 15119.773203401957, 15312.234388280569, 15458.84541154588, 15466.922665386657, 15473.92263038686, 15501.147436890966, 2725.236933658569, 2771.030139451196, 2774.875130619127, 2781.276868014311, 2783.596378525113, 2589.9223023309237, 2690.8654567271656, 2779.9722002779918, 2786.3730660601304, 2788.3029242689327, 2679.209633158223, 2686.1135825177744, 2714.185744276709, 2714.24001279642, 2717.1169369954846, 2700.1224602004427, 2708.634334364865, 2718.510668079745, 2725.8773355199064, 2750.7661848742882, 2598.9480210395686, 2650.112212408845, 2677.8928842846262, 2690.9461810763673, 2691.9865400673066, 14596.34316455762, 14708.33812478441, 14741.926290368587, 14746.483873064391, 14762.335694893756, 7880.724174653859, 8149.7147599833725, 8157.061937877161, 8160.183981601852, 8163.183681631849, 5182.119039763249, 5313.574914006909, 5463.2078348639225, 5470.480304371118, 5471.781128754845, 1905.1902941249914, 1957.2366776956999, 1972.644923913695, 1975.140813746025, 2017.7376940997576, 24709.87645061763, 24995.000199991977, 25007.874960625082, 25018.124365647298, 25153.119640812667, 6471.611703297817, 6551.4103730664465, 6700.564463309869, 6744.730210791513, 6777.525573209927, 15229.771553426708, 16737.497875063767, 16779.748303775454, 16784.748228776578, 16821.2430440628, 7615.048118985127, 7815.413843961725, 7832.765017049498, 7835.882461763078, 7859.607019649109, 7160.427165826722, 7194.460415468756, 7218.855622887513, 7219.819504512429, 7276.235995220532, 5014.548690617789, 5174.353205849269, 5176.430592634807, 5180.067587834151, 5218.425973142951, 1505.4204131409485, 1511.51631477926, 1514.3488300031092, 1529.9541013769606, 1541.0753547871188, 910.4355299714219, 916.1434059154711, 923.3813345058827, 933.3932943586723, 934.5467448287575, 7642.503237289669, 7670.539767613961, 7692.615369231516, 7715.884261736079, 7773.805654858674, 678.3589507914973, 693.9410150137194, 706.1526168597703, 707.1090426063095, 711.2318695808515, 4351.717138385995, 4884.633652476078, 5025.824096156617, 5266.894662106736, 5317.042932272228, 20046.799532004785, 20408.89795551013, 21209.575808483743, 21301.124348213103, 21302.36092917215, 19035.61928761417, 20755.169793208406, 20916.79083209179, 21192.682109768364, 21267.255646052316, 10923.781524369468, 11220.495077721522, 11403.201775875776, 11522.827157592643, 11557.422128893522, 8411.495310281403, 8496.192861678377, 8533.402661813614, 8582.82834343322, 8615.095414981588, 18040.18819153115, 18501.90749046246, 18517.0, 18577.16402761852, 18808.247670093042, 18089.638207236047, 18239.817601824343, 18480.815191848447, 18588.163532640792, 18663.626727465646, 11610.477528511068, 12149.453274602487, 12222.144449888423, 12293.139480236297, 12295.077869160028, 13559.389827457986, 13574.660633484242, 13619.523316683868, 13848.0, 13855.099418537762, 11118.166137539878, 11193.608223712132, 11202.551897924317, 11398.94300528492, 11531.308121512737, 10873.625440707816, 11062.115030797679, 11116.44417779124, 11190.88809111931, 11407.885921140682, 9810.509474526389, 9889.109980101824, 9922.950385248028, 9932.155766759906, 9944.45305508204, 7095.538789978635, 7161.85676286461, 7180.820479488055, 7181.605011724405, 7201.603911784902, 7143.570387234696, 7230.204677485367, 7230.74692385764, 7232.819179520554, 7269.091363579552], "value": 6561.616836408288, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.0493110624261, 500.01497050809917, 526.4077912348607, 526.8261473713675, 530.7770736290757, 6343.587666801666, 6351.523635727327, 6361.872762544746, 6363.204599425066, 6412.236634925398, 6029.276486821587, 6099.878002439948, 6158.766647510049, 6161.568690191689, 6207.317195108534, 4939.975300123494, 4957.405111386639, 4979.30289759434, 5002.074616196006, 5029.47190544993, 4837.153498137812, 4982.77577509013, 4999.275105109775, 4999.925001124986, 5004.274380214867, 4976.552110310071, 4982.17794063979, 5000.249962505617, 5001.649884508086, 5017.297578339036, 4955.380577427822, 4960.627952903546, 4968.776405061744, 4974.701517908901, 5006.098902197603, 4451.666125040602, 4465.263231566788, 4468.396766436522, 4499.6850220484575, 4513.119941611387, 6146.170267013986, 6167.136600875881, 6185.721642526097, 6187.721552530147, 6206.472449841769, 5704.77180912763, 5715.342735585419, 5722.313322401297, 5725.599208055438, 5732.742026608813, 6542.364408897775, 6563.3764792344655, 6564.80305590833, 6580.967095164541, 6608.801735947929, 4828.782704778293, 4842.854714358539, 4843.321934929113, 4861.052094841507, 4869.464358920516, 6828.351306625863, 6908.896366554506, 6939.895901561481, 6961.025456436002, 6987.8602427951155, 4983.476734942851, 4995.350604421402, 4997.3253610762085, 5001.999600079998, 5023.648344615842, 5051.444341122474, 5063.746812659426, 5075.746212689351, 5078.5175408336145, 5098.133317336062, 5672.574556908248, 5680.176374425685, 5703.319439863258, 5705.828825135252, 5720.599558030981, 6430.196225471816, 6492.415682588589, 6621.635810030398, 6622.238442579069, 6636.369544893228, 1621.8540331370234, 1655.329591515414, 1671.2145291712875, 1728.4555365059966, 1728.6542691461757, 1151.9712007199887, 1177.7879981603223, 1201.3572738584814, 1214.6295379909213, 1217.3304682424632, 5632.97183514088, 5651.2935883014625, 5697.715114244271, 5715.257016587901, 5796.42035796417, 6621.304762999912, 6624.840652885726, 6650.600963942179, 6702.832429189211, 6868.553544019623, 5761.366249712528, 5769.769209231584, 5803.274590676166, 5837.708114594253, 5843.2403787507355, 3495.545579074704, 3580.3197392495863, 3585.4442561403025, 3590.8400607465787, 3590.8868250842324, 6448.871022579522, 6565.21217453899, 6576.309487503839, 6580.76967306142, 6657.733690652417, 6830.180378354629, 6839.863202736017, 6867.278935711778, 6986.7205311787975, 6994.475414343945, 6499.512536559682, 6500.772472963424, 6509.511786616023, 6596.373344532261, 6596.878530649705, 6706.0, 6708.0, 6731.394174524316, 6749.886268765795, 6768.763093291908, 6640.933590664032, 6677.198736151693, 6711.355717849158, 6733.484965882637, 6798.626075565891, 6557.0, 6565.868682626417, 6637.469002479694, 6646.404862832788, 6655.534112612071, 4887.364642596582, 4903.77932993009, 4913.926291105565, 4918.704877707349, 4964.379452568429, 6463.289038205888, 6682.46540276767, 6708.953769100472, 6777.254502004874, 6825.180978282638, 6319.3364696706185, 6423.550351475352, 6524.934750652623, 6614.603123812587, 6653.467722582085, 6481.351864813481, 6562.639054852029, 6575.408213260829, 6580.539362244788, 6598.954324159526, 6329.30377658448, 6349.523785715997, 6401.0, 6433.420992110732, 6520.902186467301, 6354.204150173909, 6553.5084868634085, 6613.966930165511, 6616.735330586916, 6651.334866513504, 6386.90419643715, 6389.456896163692, 6410.435825669583, 6412.134361861089, 6416.935830641633], "value": 5056.507552931672, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.1379592815325, 856.8286342731453, 882.1927935938617, 883.0771843423622, 885.4421714319977, 19279.13243904024, 19813.603727925434, 19890.10494527746, 19901.60196796065, 21480.462988425257, 19626.116824742887, 19866.801331986713, 19906.900465497652, 20012.49968750782, 20028.0, 933.1228645073643, 950.6957773512479, 950.7813202963323, 952.49041762657, 954.6658669465701, 915.4370062411602, 952.380952380951, 966.7873067925045, 967.2697113679162, 968.438305782648, 1000.5697550053474, 1007.7329507680471, 1009.5053423822347, 1013.2147585621129, 1014.2038499777676, 987.012987012987, 1003.377905698468, 1006.1045669354207, 1006.4464544500532, 1011.0647650922867, 726.7129483853848, 737.9151397589292, 740.1192580828797, 743.275306576084, 743.4498471131324, 19257.61484770311, 19568.51078723029, 19665.11506982189, 19715.80284197154, 19753.111110000085, 20613.690794638092, 20743.170273189055, 21012.264570740102, 21124.78875211259, 21238.36284911455, 16446.75329870041, 16470.0, 16562.83437165625, 16754.4135955241, 16764.41324553647, 3693.9630603693886, 3715.3498137825773, 3715.3683873741256, 3732.608076151992, 3733.7946412947276, 126187.0, 128155.35922320328, 128269.43461130818, 131695.0, 131934.0, 15958.0, 16313.34746610146, 16701.0, 16842.915785420995, 16917.577060573338, 29705.554416683768, 29828.552571711443, 30050.398992020037, 30217.09348719498, 30412.69587304143, 7686.807829804187, 8061.0, 8615.827683446296, 9111.726648200565, 9319.673811416567, 4408.25059739845, 4532.524084971096, 4540.02389486262, 4540.069285796404, 4543.45478542577, 5027.723475208899, 5118.25785261135, 5137.640365174402, 5154.561862241751, 5167.870803229875, 1082.2802836114054, 1096.1942971915635, 1106.9889301106887, 1107.6510899066768, 1108.3405373802575, 690.413148823506, 704.6018999265399, 706.477206866925, 710.8555226085997, 712.4514124124395, 11957.820632690517, 12032.977196938358, 12165.69585760363, 12206.816897746541, 13029.934850325688, 693.2686016252902, 694.5311914457822, 696.4045740891567, 704.5772536478072, 706.0926709178681, 5587.832365028974, 5733.3406658234, 5843.94156058434, 5940.108983652401, 6032.788852390146, 104129.0, 104961.0, 106165.46917265364, 107127.0, 108027.45986270018, 92982.53508732413, 94240.0, 96668.51665741767, 97576.51211743896, 100689.49655251676, 85704.86562094165, 87788.56105719431, 89689.55155224183, 90033.54983225172, 90238.0, 12745.936270318589, 12980.870191297967, 12998.545050923172, 13096.803547946978, 13117.73764524685, 40044.79977600093, 41053.38419923763, 41153.38269925894, 41575.0, 42306.576934231496, 52029.479705202466, 52652.0, 52705.736471317396, 53060.73469632627, 54632.0, 17227.741583876003, 17552.648947021244, 17689.0, 17738.645227095127, 17769.111544422987, 19919.502012449804, 19932.20271189136, 19981.400557983285, 20193.6970945433, 20462.693059603822, 18183.18175682071, 18186.181621827312, 18192.272309107488, 18216.089195539906, 18439.53901152482, 17975.640487190445, 18005.189766460804, 18009.189586468903, 18310.725339120192, 18362.08189590542, 16757.74863377075, 17032.48902532926, 17042.65914681724, 17056.57358566046, 17240.482785516455, 13418.987151926898, 13778.311084445939, 13792.655183620089, 13878.375473103533, 13981.720365592835, 13968.930155349159, 14033.3684984178, 14168.433262669378, 14187.290635467978, 14273.143611382935], "value": 9067.817476548715, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 107.0, 96.0, 108.0, 108.0, 108.0, 113.0, 109.0, 109.0, 109.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 145.0, 196.0, 117.0, 149.0, 144.0, 118.0, 177.0, 120.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 161.0, 162.0, 161.0, 164.0, 180.0, 166.0, 161.0, 160.0, 170.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 172.0, 75.0, 77.0, 73.0, 73.0, 150.0, 75.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 133.0, 83.0, 81.0, 78.0, 125.0, 82.0, 78.0, 140.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 114.0, 115.0, 113.0, 120.0, 122.0, 114.0, 121.0, 114.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 147.0, 151.0, 149.0, 149.0, 148.0, 147.0, 150.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 99.0, 99.0, 94.0, 93.0, 94.0, 93.0, 93.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 52.0, 59.0, 54.0, 54.0, 53.0, 58.0, 53.0, 52.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 54.0, 55.0, 55.0, 56.0, 55.0, 54.0, 60.0, 60.0, 63.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 80.0, 75.0, 84.0, 81.0, 74.0, 78.0, 87.0, 79.0, 75.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 126.0, 122.0, 117.0, 117.0, 119.0, 118.0, 126.0, 118.0, 153.0], "value": 123.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 179.0, 170.0, 182.0, 174.0, 171.0, 170.0, 178.0, 171.0, 167.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 64.0, 64.0, 66.0, 63.0, 63.0, 65.0, 69.0, 74.0], "value": 67.4, "unit": "score"}]}]} 06:18:40 INFO - Return code: 0 06:18:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:18:40 INFO - # TBPL SUCCESS # 06:18:40 INFO - Running post-action listener: _package_coverage_data 06:18:40 INFO - Running post-action listener: _resource_record_post_action 06:18:40 INFO - [mozharness: 2017-08-24 13:18:40.487360Z] Finished run-tests step (success) 06:18:40 INFO - Running post-run listener: _resource_record_post_run 06:18:40 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 172032; Write bytes: 429187072; Read time: 560; Write time: 322444 06:18:40 INFO - TinderboxPrint: CPU usage
13.1% 06:18:40 INFO - TinderboxPrint: I/O read bytes / time
172,032 / 560 06:18:40 INFO - TinderboxPrint: I/O write bytes / time
429,187,072 / 322,444 06:18:40 INFO - TinderboxPrint: CPU idle
8,252.9 (86.8%) 06:18:40 INFO - TinderboxPrint: CPU user
1,197.2 (12.6%) 06:18:40 INFO - TinderboxPrint: Swap in / out
0 / 0 06:18:40 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 98304; Write bytes: 104607744; Read time: 236; Write time: 95888 06:18:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:18:40 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 69632; Write bytes: 324186112; Read time: 304; Write time: 226528 06:18:41 INFO - Running post-run listener: _upload_blobber_files 06:18:41 INFO - Blob upload gear active. 06:18:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:41 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:18:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:42 INFO - (blobuploader) - INFO - Done attempting. 06:18:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:18:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:43 INFO - (blobuploader) - INFO - Done attempting. 06:18:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:18:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:18:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:44 INFO - (blobuploader) - INFO - Done attempting. 06:18:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:18:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:18:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:52 INFO - (blobuploader) - INFO - Done attempting. 06:18:52 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:52 INFO - Return code: 0 06:18:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25c059bdf3b756b5cf2dc0d78d91987605c7e21485cd4e5bd8d09336533dcbb2d6607ce457dbfcbc73036808ccf62948c446be89c015788572f0ef482a8ba606", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5ce175bbd9ac7c9ec99a9acc0006f9fd5279b804be05f1c1c8ef11ce7af8fdff03676b517e298f7e3c46680b4f1cc8739b3dfc12c421f6ef48648e7004c0c84", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1735f1aab3c223c210c200981c29fac04d8daea88cc56fe06770c7dd7ebe0217ba0101734b4d4cb366b81c2ed64ea30c97ad8fcd9ceee9ff6511ce07a14769ae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14f4a0e0f6ba4736e57fef9f6bfe97911aa7303d5a45e749b598043b0ab96582bdbd9377f513c6ac9ea0f1f5588be4d2e5c65ec4f24832224970eec153c4add7"} 06:18:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:52 INFO - Contents: 06:18:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25c059bdf3b756b5cf2dc0d78d91987605c7e21485cd4e5bd8d09336533dcbb2d6607ce457dbfcbc73036808ccf62948c446be89c015788572f0ef482a8ba606", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5ce175bbd9ac7c9ec99a9acc0006f9fd5279b804be05f1c1c8ef11ce7af8fdff03676b517e298f7e3c46680b4f1cc8739b3dfc12c421f6ef48648e7004c0c84", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1735f1aab3c223c210c200981c29fac04d8daea88cc56fe06770c7dd7ebe0217ba0101734b4d4cb366b81c2ed64ea30c97ad8fcd9ceee9ff6511ce07a14769ae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14f4a0e0f6ba4736e57fef9f6bfe97911aa7303d5a45e749b598043b0ab96582bdbd9377f513c6ac9ea0f1f5588be4d2e5c65ec4f24832224970eec153c4add7"} 06:18:52 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:52 INFO - Copying logs to upload dir... 06:18:52 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.995305 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-24 06:18:52.171014) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 06:18:52.174605) ========= 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=652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25c059bdf3b756b5cf2dc0d78d91987605c7e21485cd4e5bd8d09336533dcbb2d6607ce457dbfcbc73036808ccf62948c446be89c015788572f0ef482a8ba606", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5ce175bbd9ac7c9ec99a9acc0006f9fd5279b804be05f1c1c8ef11ce7af8fdff03676b517e298f7e3c46680b4f1cc8739b3dfc12c421f6ef48648e7004c0c84", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1735f1aab3c223c210c200981c29fac04d8daea88cc56fe06770c7dd7ebe0217ba0101734b4d4cb366b81c2ed64ea30c97ad8fcd9ceee9ff6511ce07a14769ae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14f4a0e0f6ba4736e57fef9f6bfe97911aa7303d5a45e749b598043b0ab96582bdbd9377f513c6ac9ea0f1f5588be4d2e5c65ec4f24832224970eec153c4add7"} build_url:https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011773 build_url: 'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25c059bdf3b756b5cf2dc0d78d91987605c7e21485cd4e5bd8d09336533dcbb2d6607ce457dbfcbc73036808ccf62948c446be89c015788572f0ef482a8ba606", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5ce175bbd9ac7c9ec99a9acc0006f9fd5279b804be05f1c1c8ef11ce7af8fdff03676b517e298f7e3c46680b4f1cc8739b3dfc12c421f6ef48648e7004c0c84", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1735f1aab3c223c210c200981c29fac04d8daea88cc56fe06770c7dd7ebe0217ba0101734b4d4cb366b81c2ed64ea30c97ad8fcd9ceee9ff6511ce07a14769ae", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14f4a0e0f6ba4736e57fef9f6bfe97911aa7303d5a45e749b598043b0ab96582bdbd9377f513c6ac9ea0f1f5588be4d2e5c65ec4f24832224970eec153c4add7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 06:18:52.201930) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 06:18:52.202257) ========= 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=652eb03db935cfc1c15ebda0000001ad-1503579475.647985-1832598744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 06:18:52.285357) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 06:18:52.285673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 06:18:52.285962) ========= ========= Total master_lag: 0.18 =========