builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1504311347.82 results: success (0) revision: 5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:47.818215) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:47.818729) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:47.819022) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:47.836334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:47.836684) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-01 17:15:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.4M=0.001s 2017-09-01 17:15:47 (20.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:47.931044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:47.931416) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018671 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:47.981843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:47.982180) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772 --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 5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772 --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=31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-01 17:15:48,049 truncating revision to first 12 chars 2017-09-01 17:15:48,049 Setting DEBUG logging. 2017-09-01 17:15:48,049 attempt 1/10 2017-09-01 17:15:48,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5278dfcf5eb9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-01 17:15:48,538 unpacking tar archive at: mozilla-central-5278dfcf5eb9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.891075 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:48.891989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:48.892549) ========= script_repo_revision: 5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:48.893251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:48.893760) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 17:15:48.909132) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-01 17:15:48.909796) ========= /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=31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:15:49 INFO - MultiFileLogger online at 20170901 17:15:49 in /builds/slave/test 17:15:49 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 17:15:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:15:49 INFO - {'append_to_log': False, 17:15:49 INFO - 'base_work_dir': '/builds/slave/test', 17:15:49 INFO - 'blob_upload_branch': 'Firefox', 17:15:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:15:49 INFO - 'branch': 'Firefox', 17:15:49 INFO - 'buildbot_json_path': 'buildprops.json', 17:15:49 INFO - 'code_coverage': False, 17:15:49 INFO - 'config_files': ('talos/linux_config.py',), 17:15:49 INFO - 'default_actions': ('clobber', 17:15:49 INFO - 'read-buildbot-config', 17:15:49 INFO - 'download-and-extract', 17:15:49 INFO - 'populate-webroot', 17:15:49 INFO - 'create-virtualenv', 17:15:49 INFO - 'install', 17:15:49 INFO - 'setup-mitmproxy', 17:15:49 INFO - 'run-tests'), 17:15:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:15:49 INFO - 'disable_ccov_upload': False, 17:15:49 INFO - 'disable_stylo': False, 17:15:49 INFO - 'download_minidump_stackwalk': True, 17:15:49 INFO - 'download_symbols': 'ondemand', 17:15:49 INFO - 'enable_stylo': False, 17:15:49 INFO - 'enable_webrender': False, 17:15:49 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:15:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:15:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:15:49 INFO - 'gecko_profile': False, 17:15:49 INFO - 'gecko_profile_interval': 0, 17:15:49 INFO - 'installer_path': 'installer.exe', 17:15:49 INFO - 'log_level': 'info', 17:15:49 INFO - 'log_name': 'talos', 17:15:49 INFO - 'log_to_console': True, 17:15:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:15:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:15:49 INFO - 'opt_config_files': (), 17:15:49 INFO - 'pip_index': False, 17:15:49 INFO - 'suite': 'dromaeojs-e10s', 17:15:49 INFO - 'system_bits': '32', 17:15:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:15:49 INFO - 'title': 'talos-linux64-ix-014', 17:15:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:15:49 INFO - 'use_talos_json': True, 17:15:49 INFO - 'verify': 'False', 17:15:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:15:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:15:49 INFO - 'work_dir': 'build'} 17:15:49 INFO - [mozharness: 2017-09-02 00:15:49.115876Z] Running clobber step. 17:15:49 INFO - Running pre-action listener: _resource_record_pre_action 17:15:49 INFO - Running main action method: clobber 17:15:49 INFO - rmtree: /builds/slave/test/build 17:15:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:15:50 INFO - Running post-action listener: _resource_record_post_action 17:15:50 INFO - [mozharness: 2017-09-02 00:15:50.128203Z] Finished clobber step (success) 17:15:50 INFO - [mozharness: 2017-09-02 00:15:50.128301Z] Running read-buildbot-config step. 17:15:50 INFO - Running pre-action listener: _resource_record_pre_action 17:15:50 INFO - Running main action method: read_buildbot_config 17:15:50 INFO - Using buildbot properties: 17:15:50 INFO - { 17:15:50 INFO - "project": "", 17:15:50 INFO - "product": "firefox", 17:15:50 INFO - "who": "kwierso@gmail.com", 17:15:50 INFO - "installer_path": "public/build/target.tar.bz2", 17:15:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 17:15:50 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:15:50 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 17:15:50 INFO - "stage_platform": "linux64-stylosequential", 17:15:50 INFO - "basedir": "/builds/slave/test", 17:15:50 INFO - "buildnumber": 225, 17:15:50 INFO - "platform": "ubuntu64_hw_styloseq", 17:15:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:15:50 INFO - "slavebuilddir": "test", 17:15:50 INFO - "taskId": "GgbBaO6-Tkmee4_WihMP5Q", 17:15:50 INFO - "branch": "mozilla-central", 17:15:50 INFO - "script_repo_revision": "production", 17:15:50 INFO - "revision": "5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772", 17:15:50 INFO - "slavename": "talos-linux64-ix-014", 17:15:50 INFO - "repo_path": "mozilla-central" 17:15:50 INFO - } 17:15:50 INFO - Finding installer, test and symbols from parent task. 17:15:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GgbBaO6-Tkmee4_WihMP5Q'}, attempt #1 17:15:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GgbBaO6-Tkmee4_WihMP5Q'}, attempt #1 17:15:51 INFO - Task dependencies: Dw0q0U3MRZ6Rav7W5HAwLw 17:15:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw'}, attempt #1 17:15:51 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.tar.bz2 17:15:51 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.test_packages.json 17:15:51 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.crashreporter-symbols.zip 17:15:51 INFO - Running post-action listener: _resource_record_post_action 17:15:51 INFO - [mozharness: 2017-09-02 00:15:51.486965Z] Finished read-buildbot-config step (success) 17:15:51 INFO - [mozharness: 2017-09-02 00:15:51.487184Z] Running download-and-extract step. 17:15:51 INFO - Running pre-action listener: _resource_record_pre_action 17:15:51 INFO - Running main action method: download_and_extract 17:15:51 INFO - mkdir: /builds/slave/test/build/tests 17:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:51 INFO - trying https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.test_packages.json 17:15:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:15:52 INFO - Downloaded 989 bytes. 17:15:52 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:15:52 INFO - Using the following test package requirements: 17:15:52 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:15:52 INFO - u'common': [u'target.common.tests.zip'], 17:15:52 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:15:52 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:15:52 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:15:52 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:15:52 INFO - u'mozbase': [u'target.common.tests.zip'], 17:15:52 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:15:52 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:15:52 INFO - u'web-platform': [u'target.common.tests.zip', 17:15:52 INFO - u'target.web-platform.tests.tar.gz'], 17:15:52 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:15:52 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:15:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.common.tests.zip 17:15:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:15:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.common.tests.zip into memory 17:15:53 INFO - Content-Length response header: 54958091 17:15:53 INFO - Bytes received: 54958091 17:16:03 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:16:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.common.tests.zip 17:16:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:16:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.common.tests.zip into memory 17:16:05 INFO - Content-Length response header: 54958091 17:16:05 INFO - Bytes received: 54958091 17:16:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.talos.tests.zip 17:16:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:16:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.talos.tests.zip into memory 17:16:17 INFO - Content-Length response header: 14496650 17:16:17 INFO - Bytes received: 14496650 17:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:18 INFO - trying https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.tar.bz2 17:16:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:16:27 INFO - Downloaded 62544014 bytes. 17:16:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.tar.bz2 17:16:27 INFO - mkdir: /builds/slave/test/properties 17:16:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:16:27 INFO - Writing to file /builds/slave/test/properties/build_url 17:16:27 INFO - Contents: 17:16:27 INFO - build_url:https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.tar.bz2 17:16:27 INFO - Running post-action listener: _resource_record_post_action 17:16:27 INFO - Running post-action listener: find_tests_for_verification 17:16:27 INFO - Running post-action listener: set_extra_try_arguments 17:16:27 INFO - [mozharness: 2017-09-02 00:16:27.013800Z] Finished download-and-extract step (success) 17:16:27 INFO - [mozharness: 2017-09-02 00:16:27.013898Z] Running populate-webroot step. 17:16:27 INFO - Running pre-action listener: _resource_record_pre_action 17:16:27 INFO - Running main action method: populate_webroot 17:16:27 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:16:27 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:16:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:16:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:16:27 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:16:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:16:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:16:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:27 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:16:27 INFO - 'talos_options': ['--enable-stylo'], 17:16:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:16:27 INFO - 'tests': ['damp', 'tps']}, 17:16:27 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:16:27 INFO - 'talos_options': ['--enable-stylo'], 17:16:27 INFO - 'tests': ['damp', 'tps']}, 17:16:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:16:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:16:27 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:16:27 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:16:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:16:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:16:27 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:16:27 INFO - 'talos_options': ['--enable-stylo'], 17:16:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:16:27 INFO - 'other-e10s': {'tests': ['a11yr', 17:16:27 INFO - 'ts_paint', 17:16:27 INFO - 'tpaint', 17:16:27 INFO - 'sessionrestore', 17:16:27 INFO - 'sessionrestore_many_windows', 17:16:27 INFO - 'sessionrestore_no_auto_restore', 17:16:27 INFO - 'tabpaint']}, 17:16:27 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:16:27 INFO - 'tests': ['a11yr', 17:16:27 INFO - 'ts_paint', 17:16:27 INFO - 'tpaint', 17:16:27 INFO - 'sessionrestore', 17:16:27 INFO - 'sessionrestore_many_windows', 17:16:27 INFO - 'sessionrestore_no_auto_restore', 17:16:27 INFO - 'tabpaint']}, 17:16:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:16:27 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:16:27 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:16:27 INFO - 'tests': ['bloom_basic_singleton']}, 17:16:27 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:16:27 INFO - 'tests': ['bloom_basic']}, 17:16:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:16:27 INFO - 'tsvgr_opacity', 17:16:27 INFO - 'tart', 17:16:27 INFO - 'tscrollx', 17:16:27 INFO - 'tsvg_static']}, 17:16:27 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:16:27 INFO - 'tests': ['tsvgx', 17:16:27 INFO - 'tsvgr_opacity', 17:16:27 INFO - 'tart', 17:16:27 INFO - 'tscrollx', 17:16:27 INFO - 'tsvg_static']}, 17:16:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:16:27 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:16:27 INFO - 'talos_options': ['--enable-stylo'], 17:16:27 INFO - 'tests': ['tp5o']}, 17:16:27 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:16:27 INFO - 'talos_options': ['--mitmproxy', 17:16:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:16:27 INFO - '--firstNonBlankPaint'], 17:16:27 INFO - 'tests': ['tp6_google', 17:16:27 INFO - 'tp6_youtube', 17:16:27 INFO - 'tp6_amazon', 17:16:27 INFO - 'tp6_facebook']}, 17:16:27 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:16:27 INFO - 'talos_options': ['--enable-stylo', 17:16:27 INFO - '--mitmproxy', 17:16:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:16:27 INFO - '--firstNonBlankPaint'], 17:16:27 INFO - 'tests': ['tp6_google', 17:16:27 INFO - 'tp6_youtube', 17:16:27 INFO - 'tp6_amazon', 17:16:27 INFO - 'tp6_facebook']}, 17:16:27 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:16:27 INFO - 'talos_options': ['--enable-stylo', 17:16:27 INFO - '--stylo-threads=1', 17:16:27 INFO - '--mitmproxy', 17:16:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:16:27 INFO - '--firstNonBlankPaint'], 17:16:27 INFO - 'tests': ['tp6_google', 17:16:27 INFO - 'tp6_youtube', 17:16:27 INFO - 'tp6_amazon', 17:16:27 INFO - 'tp6_facebook']}, 17:16:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:16:27 INFO - 'talos_options': ['--xperf_path', 17:16:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:27 INFO - 'tests': ['tp5n']}, 17:16:27 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:16:27 INFO - 'talos_options': ['--enable-stylo', 17:16:27 INFO - '--xperf_path', 17:16:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:27 INFO - 'tests': ['tp5n']}}} 17:16:27 INFO - Running post-action listener: _resource_record_post_action 17:16:27 INFO - [mozharness: 2017-09-02 00:16:27.028281Z] Finished populate-webroot step (success) 17:16:27 INFO - [mozharness: 2017-09-02 00:16:27.028370Z] Running create-virtualenv step. 17:16:27 INFO - Running pre-action listener: _resource_record_pre_action 17:16:27 INFO - Running main action method: create_virtualenv 17:16:27 INFO - Creating virtualenv /builds/slave/test/build/venv 17:16:27 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:16:27 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:16:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:16:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:16:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:16:27 INFO - Installing distribute.............................................................................................................................................................................................done. 17:16:27 INFO - Installing pip...............done. 17:16:27 INFO - Return code: 0 17:16:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:16:28 INFO - Reading from file tmpfile_stdout 17:16:28 INFO - Output received: 17:16:28 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:16:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f090>, '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 0x1d0fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:16:28 INFO - Using env: {'DISPLAY': ':0', 17:16:28 INFO - 'HOME': '/home/cltbld', 17:16:28 INFO - 'LANG': 'en_US.UTF-8', 17:16:28 INFO - 'LANGUAGE': 'en_US:en', 17:16:28 INFO - 'LOGNAME': 'cltbld', 17:16:28 INFO - 'MAIL': '/var/mail/cltbld', 17:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:28 INFO - 'MOZ_NO_REMOTE': '1', 17:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:28 INFO - 'NO_EM_RESTART': '1', 17:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:28 INFO - 'PWD': '/builds/slave/test', 17:16:28 INFO - 'SHELL': '/bin/bash', 17:16:28 INFO - 'SHLVL': '1', 17:16:28 INFO - 'TERM': 'linux', 17:16:28 INFO - 'TMOUT': '86400', 17:16:28 INFO - 'USER': 'cltbld', 17:16:28 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:28 INFO - '_': '/tools/buildbot/bin/python'} 17:16:29 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:16:29 INFO - Downloading/unpacking pip>=1.5 17:16:29 INFO - Running setup.py egg_info for package pip 17:16:29 INFO - warning: no files found matching 'pip/cacert.pem' 17:16:29 INFO - warning: no files found matching '*.html' under directory 'docs' 17:16:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:16:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:16:29 INFO - Installing collected packages: pip 17:16:29 INFO - Found existing installation: pip 1.1 17:16:29 INFO - Uninstalling pip: 17:16:29 INFO - Successfully uninstalled pip 17:16:29 INFO - Running setup.py install for pip 17:16:29 INFO - warning: no files found matching 'pip/cacert.pem' 17:16:29 INFO - warning: no files found matching '*.html' under directory 'docs' 17:16:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:16:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:16:29 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:16:29 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:16:29 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:16:29 INFO - Successfully installed pip 17:16:29 INFO - Cleaning up... 17:16:29 INFO - Return code: 0 17:16:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f090>, '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 0x1d0fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:16:29 INFO - Using env: {'DISPLAY': ':0', 17:16:29 INFO - 'HOME': '/home/cltbld', 17:16:29 INFO - 'LANG': 'en_US.UTF-8', 17:16:29 INFO - 'LANGUAGE': 'en_US:en', 17:16:29 INFO - 'LOGNAME': 'cltbld', 17:16:29 INFO - 'MAIL': '/var/mail/cltbld', 17:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:29 INFO - 'MOZ_NO_REMOTE': '1', 17:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:29 INFO - 'NO_EM_RESTART': '1', 17:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:29 INFO - 'PWD': '/builds/slave/test', 17:16:29 INFO - 'SHELL': '/bin/bash', 17:16:29 INFO - 'SHLVL': '1', 17:16:29 INFO - 'TERM': 'linux', 17:16:29 INFO - 'TMOUT': '86400', 17:16:29 INFO - 'USER': 'cltbld', 17:16:29 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:29 INFO - '_': '/tools/buildbot/bin/python'} 17:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:29 INFO - Downloading/unpacking psutil>=3.1.1 17:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:16:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:30 INFO - Installing collected packages: psutil 17:16:30 INFO - Running setup.py install for psutil 17:16:30 INFO - building 'psutil._psutil_linux' extension 17:16:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:16:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:16:30 INFO - building 'psutil._psutil_posix' extension 17:16:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:16:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:16:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:31 INFO - Successfully installed psutil 17:16:31 INFO - Cleaning up... 17:16:31 INFO - Return code: 0 17:16:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:31 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 0x199f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f090>, '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 0x1d0fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:16:31 INFO - Using env: {'DISPLAY': ':0', 17:16:31 INFO - 'HOME': '/home/cltbld', 17:16:31 INFO - 'LANG': 'en_US.UTF-8', 17:16:31 INFO - 'LANGUAGE': 'en_US:en', 17:16:31 INFO - 'LOGNAME': 'cltbld', 17:16:31 INFO - 'MAIL': '/var/mail/cltbld', 17:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:31 INFO - 'MOZ_NO_REMOTE': '1', 17:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:31 INFO - 'NO_EM_RESTART': '1', 17:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:31 INFO - 'PWD': '/builds/slave/test', 17:16:31 INFO - 'SHELL': '/bin/bash', 17:16:31 INFO - 'SHLVL': '1', 17:16:31 INFO - 'TERM': 'linux', 17:16:31 INFO - 'TMOUT': '86400', 17:16:31 INFO - 'USER': 'cltbld', 17:16:31 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:31 INFO - '_': '/tools/buildbot/bin/python'} 17:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:16: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 17:16: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 17:16: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 17:16: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 17:16:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:16:32 INFO - Installing collected packages: mozsystemmonitor 17:16:32 INFO - Running setup.py install for mozsystemmonitor 17:16:32 INFO - Successfully installed mozsystemmonitor 17:16:32 INFO - Cleaning up... 17:16:32 INFO - Return code: 0 17:16:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16: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')]} 17:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16: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', '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 0x199f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f090>, '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 0x1d0fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:16: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 jsonschema==2.5.1 17:16:32 INFO - Using env: {'DISPLAY': ':0', 17:16:32 INFO - 'HOME': '/home/cltbld', 17:16:32 INFO - 'LANG': 'en_US.UTF-8', 17:16:32 INFO - 'LANGUAGE': 'en_US:en', 17:16:32 INFO - 'LOGNAME': 'cltbld', 17:16:32 INFO - 'MAIL': '/var/mail/cltbld', 17:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:32 INFO - 'MOZ_NO_REMOTE': '1', 17:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:32 INFO - 'NO_EM_RESTART': '1', 17:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:32 INFO - 'PWD': '/builds/slave/test', 17:16:32 INFO - 'SHELL': '/bin/bash', 17:16:32 INFO - 'SHLVL': '1', 17:16:32 INFO - 'TERM': 'linux', 17:16:32 INFO - 'TMOUT': '86400', 17:16:32 INFO - 'USER': 'cltbld', 17:16:32 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:32 INFO - '_': '/tools/buildbot/bin/python'} 17:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:32 INFO - Downloading/unpacking jsonschema==2.5.1 17:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:16:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16: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 17:16: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 17:16:34 INFO - Downloading functools32-3.2.3-2.tar.gz 17:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:16:34 INFO - warning: no files found matching '*.txt' 17:16:34 INFO - no previously-included directories found matching 'build' 17:16:34 INFO - no previously-included directories found matching 'dist' 17:16:34 INFO - no previously-included directories found matching '.git*' 17:16:34 INFO - Installing collected packages: jsonschema, functools32 17:16:34 INFO - Running setup.py install for functools32 17:16:34 INFO - warning: no files found matching '*.txt' 17:16:34 INFO - no previously-included directories found matching 'build' 17:16:34 INFO - no previously-included directories found matching 'dist' 17:16:34 INFO - no previously-included directories found matching '.git*' 17:16:34 INFO - Successfully installed jsonschema functools32 17:16:34 INFO - Cleaning up... 17:16:34 INFO - Return code: 0 17:16:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16: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')]} 17:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16: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', '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 0x199f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f090>, '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 0x1d0fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:16: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 functools32==3.2.3-2 17:16:34 INFO - Using env: {'DISPLAY': ':0', 17:16:34 INFO - 'HOME': '/home/cltbld', 17:16:34 INFO - 'LANG': 'en_US.UTF-8', 17:16:34 INFO - 'LANGUAGE': 'en_US:en', 17:16:34 INFO - 'LOGNAME': 'cltbld', 17:16:34 INFO - 'MAIL': '/var/mail/cltbld', 17:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:34 INFO - 'MOZ_NO_REMOTE': '1', 17:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:34 INFO - 'NO_EM_RESTART': '1', 17:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:34 INFO - 'PWD': '/builds/slave/test', 17:16:34 INFO - 'SHELL': '/bin/bash', 17:16:34 INFO - 'SHLVL': '1', 17:16:34 INFO - 'TERM': 'linux', 17:16:34 INFO - 'TMOUT': '86400', 17:16:34 INFO - 'USER': 'cltbld', 17:16:34 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:34 INFO - '_': '/tools/buildbot/bin/python'} 17:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:16:34 INFO - Cleaning up... 17:16:34 INFO - Return code: 0 17:16:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16: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')]} 17:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16: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', '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 0x199f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f090>, '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 0x1d0fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:16: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 blobuploader==1.2.4 17:16:34 INFO - Using env: {'DISPLAY': ':0', 17:16:34 INFO - 'HOME': '/home/cltbld', 17:16:34 INFO - 'LANG': 'en_US.UTF-8', 17:16:34 INFO - 'LANGUAGE': 'en_US:en', 17:16:34 INFO - 'LOGNAME': 'cltbld', 17:16:34 INFO - 'MAIL': '/var/mail/cltbld', 17:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:34 INFO - 'MOZ_NO_REMOTE': '1', 17:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:34 INFO - 'NO_EM_RESTART': '1', 17:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:34 INFO - 'PWD': '/builds/slave/test', 17:16:34 INFO - 'SHELL': '/bin/bash', 17:16:34 INFO - 'SHLVL': '1', 17:16:34 INFO - 'TERM': 'linux', 17:16:34 INFO - 'TMOUT': '86400', 17:16:34 INFO - 'USER': 'cltbld', 17:16:34 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:34 INFO - '_': '/tools/buildbot/bin/python'} 17:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:34 INFO - Downloading/unpacking blobuploader==1.2.4 17:16: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 17:16: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 17:16: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 17:16: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 17:16:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:16:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:16:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:36 INFO - Downloading docopt-0.6.1.tar.gz 17:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:16:36 INFO - Installing collected packages: blobuploader, requests, docopt 17:16:36 INFO - Running setup.py install for blobuploader 17:16:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:16:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:16:36 INFO - Running setup.py install for requests 17:16:36 INFO - Running setup.py install for docopt 17:16:37 INFO - Successfully installed blobuploader requests docopt 17:16:37 INFO - Cleaning up... 17:16:37 INFO - Return code: 0 17:16:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:37 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 0x199f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f090>, '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 0x1d0fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:16:37 INFO - Using env: {'DISPLAY': ':0', 17:16:37 INFO - 'HOME': '/home/cltbld', 17:16:37 INFO - 'LANG': 'en_US.UTF-8', 17:16:37 INFO - 'LANGUAGE': 'en_US:en', 17:16:37 INFO - 'LOGNAME': 'cltbld', 17:16:37 INFO - 'MAIL': '/var/mail/cltbld', 17:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:37 INFO - 'MOZ_NO_REMOTE': '1', 17:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:37 INFO - 'NO_EM_RESTART': '1', 17:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:37 INFO - 'PWD': '/builds/slave/test', 17:16:37 INFO - 'SHELL': '/bin/bash', 17:16:37 INFO - 'SHLVL': '1', 17:16:37 INFO - 'TERM': 'linux', 17:16:37 INFO - 'TMOUT': '86400', 17:16:37 INFO - 'USER': 'cltbld', 17:16:37 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:37 INFO - '_': '/tools/buildbot/bin/python'} 17:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:37 INFO - Running setup.py (path:/tmp/pip-l6r9sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:37 INFO - Running setup.py (path:/tmp/pip-56LLtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:37 INFO - Running setup.py (path:/tmp/pip-mcdQRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:37 INFO - Running setup.py (path:/tmp/pip-8gdvte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:37 INFO - Running setup.py (path:/tmp/pip-eyn9DX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:37 INFO - Running setup.py (path:/tmp/pip-4Pvj24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:37 INFO - Running setup.py (path:/tmp/pip-Tiu_kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:37 INFO - Running setup.py (path:/tmp/pip-N6c1_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:37 INFO - Running setup.py (path:/tmp/pip-poUpvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:37 INFO - Running setup.py (path:/tmp/pip-KGKFWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:38 INFO - Running setup.py (path:/tmp/pip-my9ZJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:38 INFO - Running setup.py (path:/tmp/pip-TOzYFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:38 INFO - Running setup.py (path:/tmp/pip-mejqQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:38 INFO - Running setup.py (path:/tmp/pip-oKCUzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:38 INFO - Running setup.py (path:/tmp/pip-cRoz2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:38 INFO - Running setup.py (path:/tmp/pip-y8UNp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:38 INFO - Running setup.py (path:/tmp/pip-p4oufG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:16:38 INFO - Running setup.py install for manifestparser 17:16:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:16:38 INFO - Running setup.py install for mozcrash 17:16:38 INFO - Running setup.py install for mozdebug 17:16:38 INFO - Running setup.py install for mozdevice 17:16:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:16:38 INFO - Running setup.py install for mozfile 17:16:39 INFO - Running setup.py install for mozhttpd 17:16:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:16:39 INFO - Running setup.py install for mozinfo 17:16:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:16:39 INFO - Running setup.py install for mozInstall 17:16:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:16:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:16:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:16:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:16:39 INFO - Running setup.py install for mozleak 17:16:39 INFO - Running setup.py install for mozlog 17:16:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:16:39 INFO - Running setup.py install for moznetwork 17:16:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:16:39 INFO - Running setup.py install for mozprocess 17:16:39 INFO - Running setup.py install for mozprofile 17:16:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:16:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:16:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:16:39 INFO - Running setup.py install for mozrunner 17:16:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:16:39 INFO - Running setup.py install for mozscreenshot 17:16:40 INFO - Running setup.py install for moztest 17:16:40 INFO - Running setup.py install for mozversion 17:16:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:16:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:16:40 INFO - Cleaning up... 17:16:40 INFO - Return code: 0 17:16:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:40 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 0x199f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f090>, '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 0x1d0fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:16:40 INFO - Using env: {'DISPLAY': ':0', 17:16:40 INFO - 'HOME': '/home/cltbld', 17:16:40 INFO - 'LANG': 'en_US.UTF-8', 17:16:40 INFO - 'LANGUAGE': 'en_US:en', 17:16:40 INFO - 'LOGNAME': 'cltbld', 17:16:40 INFO - 'MAIL': '/var/mail/cltbld', 17:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:40 INFO - 'MOZ_NO_REMOTE': '1', 17:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:40 INFO - 'NO_EM_RESTART': '1', 17:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:40 INFO - 'PWD': '/builds/slave/test', 17:16:40 INFO - 'SHELL': '/bin/bash', 17:16:40 INFO - 'SHLVL': '1', 17:16:40 INFO - 'TERM': 'linux', 17:16:40 INFO - 'TMOUT': '86400', 17:16:40 INFO - 'USER': 'cltbld', 17:16:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:40 INFO - '_': '/tools/buildbot/bin/python'} 17:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:40 INFO - Running setup.py (path:/tmp/pip-GB1uGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:40 INFO - Running setup.py (path:/tmp/pip-SBbKnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:40 INFO - Running setup.py (path:/tmp/pip-MvLwuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:40 INFO - Running setup.py (path:/tmp/pip-R_QuxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:40 INFO - Running setup.py (path:/tmp/pip-0NmZCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:40 INFO - Running setup.py (path:/tmp/pip-crWZMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:40 INFO - Running setup.py (path:/tmp/pip-DKJ81G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:41 INFO - Running setup.py (path:/tmp/pip-sjS0tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:41 INFO - Running setup.py (path:/tmp/pip-pJr56N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:41 INFO - Running setup.py (path:/tmp/pip-oK8Z5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:41 INFO - Running setup.py (path:/tmp/pip-AHw2qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:41 INFO - Running setup.py (path:/tmp/pip-ujL__N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:41 INFO - Running setup.py (path:/tmp/pip-arLpWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:41 INFO - Running setup.py (path:/tmp/pip-cH7uwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:41 INFO - Running setup.py (path:/tmp/pip-xTnkcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:41 INFO - Running setup.py (path:/tmp/pip-Ung3T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:41 INFO - Running setup.py (path:/tmp/pip-rijFQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:16:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - Downloading blessings-1.6.tar.gz 17:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:16:42 INFO - Installing collected packages: blessings 17:16:42 INFO - Running setup.py install for blessings 17:16:42 INFO - Successfully installed blessings 17:16:42 INFO - Cleaning up... 17:16:43 INFO - Return code: 0 17:16:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:43 INFO - Reading from file tmpfile_stdout 17:16:43 INFO - Current package versions: 17:16:43 INFO - argparse == 1.2.1 17:16:43 INFO - blessings == 1.6 17:16:43 INFO - blobuploader == 1.2.4 17:16:43 INFO - docopt == 0.6.1 17:16:43 INFO - functools32 == 3.2.3-2 17:16:43 INFO - jsonschema == 2.5.1 17:16:43 INFO - manifestparser == 1.1 17:16:43 INFO - mozInstall == 1.13 17:16:43 INFO - mozcrash == 1.0 17:16:43 INFO - mozdebug == 0.1 17:16:43 INFO - mozdevice == 0.51 17:16:43 INFO - mozfile == 1.2 17:16:43 INFO - mozhttpd == 0.7 17:16:43 INFO - mozinfo == 0.10 17:16:43 INFO - mozleak == 0.1 17:16:43 INFO - mozlog == 3.5 17:16:43 INFO - moznetwork == 0.27 17:16:43 INFO - mozprocess == 0.25 17:16:43 INFO - mozprofile == 0.28 17:16:43 INFO - mozrunner == 6.13 17:16:43 INFO - mozscreenshot == 0.1 17:16:43 INFO - mozsystemmonitor == 0.3 17:16:43 INFO - moztest == 0.8 17:16:43 INFO - mozversion == 1.4 17:16:43 INFO - psutil == 3.1.1 17:16:43 INFO - requests == 1.2.3 17:16:43 INFO - wsgiref == 0.1.2 17:16:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:43 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 0x199f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f090>, '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 0x1d0fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:16:43 INFO - Using env: {'DISPLAY': ':0', 17:16:43 INFO - 'HOME': '/home/cltbld', 17:16:43 INFO - 'LANG': 'en_US.UTF-8', 17:16:43 INFO - 'LANGUAGE': 'en_US:en', 17:16:43 INFO - 'LOGNAME': 'cltbld', 17:16:43 INFO - 'MAIL': '/var/mail/cltbld', 17:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:43 INFO - 'MOZ_NO_REMOTE': '1', 17:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:43 INFO - 'NO_EM_RESTART': '1', 17:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:43 INFO - 'PWD': '/builds/slave/test', 17:16:43 INFO - 'SHELL': '/bin/bash', 17:16:43 INFO - 'SHLVL': '1', 17:16:43 INFO - 'TERM': 'linux', 17:16:43 INFO - 'TMOUT': '86400', 17:16:43 INFO - 'USER': 'cltbld', 17:16:43 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:43 INFO - '_': '/tools/buildbot/bin/python'} 17:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:16:43 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:16: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 17:16: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 17:16: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 17:16: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 17:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:16:44 INFO - Installing collected packages: simplejson 17:16:44 INFO - Running setup.py install for simplejson 17:16:44 INFO - building 'simplejson._speedups' extension 17:16:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 17:16:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:16:45 INFO - Successfully installed simplejson 17:16:45 INFO - Cleaning up... 17:16:45 INFO - Return code: 0 17:16:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0f090>, '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 0x1d0fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f90>, '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': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:16:45 INFO - Using env: {'DISPLAY': ':0', 17:16:45 INFO - 'HOME': '/home/cltbld', 17:16:45 INFO - 'LANG': 'en_US.UTF-8', 17:16:45 INFO - 'LANGUAGE': 'en_US:en', 17:16:45 INFO - 'LOGNAME': 'cltbld', 17:16:45 INFO - 'MAIL': '/var/mail/cltbld', 17:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:45 INFO - 'MOZ_NO_REMOTE': '1', 17:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:45 INFO - 'NO_EM_RESTART': '1', 17:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:45 INFO - 'PWD': '/builds/slave/test', 17:16:45 INFO - 'SHELL': '/bin/bash', 17:16:45 INFO - 'SHLVL': '1', 17:16:45 INFO - 'TERM': 'linux', 17:16:45 INFO - 'TMOUT': '86400', 17:16:45 INFO - 'USER': 'cltbld', 17:16:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:45 INFO - '_': '/tools/buildbot/bin/python'} 17:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:16:45 INFO - Cleaning up... 17:16:45 INFO - Return code: 0 17:16:45 INFO - Running post-action listener: _resource_record_post_action 17:16:45 INFO - Running post-action listener: _start_resource_monitoring 17:16:45 INFO - Starting resource monitoring. 17:16:45 INFO - [mozharness: 2017-09-02 00:16:45.951375Z] Finished create-virtualenv step (success) 17:16:45 INFO - [mozharness: 2017-09-02 00:16:45.951838Z] Running install step. 17:16:45 INFO - Running pre-action listener: _resource_record_pre_action 17:16:45 INFO - Running main action method: install 17:16:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:46 INFO - Reading from file tmpfile_stdout 17:16:46 INFO - Detecting whether we're running mozinstall >=1.0... 17:16:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:16:46 INFO - Reading from file tmpfile_stdout 17:16:46 INFO - Output received: 17:16:46 INFO - Usage: mozinstall [options] installer 17:16:46 INFO - Options: 17:16:46 INFO - -h, --help show this help message and exit 17:16:46 INFO - -d DEST, --destination=DEST 17:16:46 INFO - Directory to install application into. [default: 17:16:46 INFO - "/builds/slave/test"] 17:16:46 INFO - --app=APP Application being installed. [default: firefox] 17:16:46 INFO - mkdir: /builds/slave/test/build/application 17:16:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:17:02 INFO - Reading from file tmpfile_stdout 17:17:02 INFO - Output received: 17:17:02 INFO - /builds/slave/test/build/application/firefox/firefox 17:17:02 INFO - Running post-action listener: _resource_record_post_action 17:17:02 INFO - [mozharness: 2017-09-02 00:17:02.963120Z] Finished install step (success) 17:17:02 INFO - [mozharness: 2017-09-02 00:17:02.963266Z] Running setup-mitmproxy step. 17:17:02 INFO - Running pre-action listener: _resource_record_pre_action 17:17:02 INFO - Running main action method: setup_mitmproxy 17:17:02 INFO - Skipping: mitmproxy is not required 17:17:02 INFO - Running post-action listener: _resource_record_post_action 17:17:02 INFO - [mozharness: 2017-09-02 00:17:02.963794Z] Finished setup-mitmproxy step (success) 17:17:02 INFO - [mozharness: 2017-09-02 00:17:02.963895Z] Running run-tests step. 17:17:02 INFO - Running pre-action listener: _resource_record_pre_action 17:17:02 INFO - Running pre-action listener: _set_gcov_prefix 17:17:02 INFO - Running main action method: run_tests 17:17:02 WARNING - Try message not found. 17:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:17:02 INFO - Python 2.7.3 17:17:02 INFO - Return code: 0 17:17:02 INFO - grabbing minidump binary from tooltool 17:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:02 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 0x1d0f090>, '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 0x1d0fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:17:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:17:02 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:17:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:17:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:17:03 INFO - Return code: 0 17:17:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:17:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:17:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:17:03 INFO - ENV: RUST_BACKTRACE is now full 17:17:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:17:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:17:03 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/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 17:17:03 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/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 17:17:03 INFO - Using env: {'DISPLAY': ':0', 17:17:03 INFO - 'HOME': '/home/cltbld', 17:17:03 INFO - 'LANG': 'en_US.UTF-8', 17:17:03 INFO - 'LANGUAGE': 'en_US:en', 17:17:03 INFO - 'LOGNAME': 'cltbld', 17:17:03 INFO - 'MAIL': '/var/mail/cltbld', 17:17:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:17:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:03 INFO - 'MOZ_NO_REMOTE': '1', 17:17:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:03 INFO - 'NO_EM_RESTART': '1', 17:17:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:03 INFO - 'PWD': '/builds/slave/test', 17:17:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:17:03 INFO - 'RUST_BACKTRACE': 'full', 17:17:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:17:03 INFO - 'SHELL': '/bin/bash', 17:17:03 INFO - 'SHLVL': '1', 17:17:03 INFO - 'STYLO_FORCE_ENABLED': '1', 17:17:03 INFO - 'STYLO_THREADS': '1', 17:17:03 INFO - 'TERM': 'linux', 17:17:03 INFO - 'TMOUT': '86400', 17:17:03 INFO - 'USER': 'cltbld', 17:17:03 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:03 INFO - '_': '/tools/buildbot/bin/python'} 17:17:03 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/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 17:17:03 INFO - mozversion application_buildid: 20170901232924 17:17:03 INFO - mozversion application_changeset: 5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772 17:17:03 INFO - mozversion application_display_name: Nightly 17:17:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:17:03 INFO - mozversion application_name: Firefox 17:17:03 INFO - mozversion application_remotingname: firefox 17:17:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:17:03 INFO - mozversion application_vendor: Mozilla 17:17:03 INFO - mozversion application_version: 57.0a1 17:17:03 INFO - mozversion platform_buildid: 20170901232924 17:17:03 INFO - mozversion platform_changeset: 5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772 17:17:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:17:03 INFO - mozversion platform_version: 57.0a1 17:17:03 INFO - using testdate: 1504311423 17:17:03 INFO - actual date: 1504311423 17:17:03 INFO - starting webserver on 'localhost:57104' 17:17:03 INFO - SUITE-START | Running 2 tests 17:17:03 INFO - TEST-START | dromaeo_css 17:17:03 INFO - Initialising browser for dromaeo_css test... 17:17:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57104/getInfo.html -profile /tmp/tmp_VsjLv/profile 17:17:03 INFO - TEST-INFO | started process 23969 (/builds/slave/test/build/application/firefox/firefox http://localhost:57104/getInfo.html) 17:17:08 INFO - TEST-INFO | 23969: exit 0 17:17:08 INFO - Browser initialized. 17:17:08 INFO - Running cycle 1/1 for dromaeo_css test... 17:17:08 INFO - Using env: {'DISPLAY': ':0', 17:17:08 INFO - 'HOME': '/home/cltbld', 17:17:08 INFO - 'JSGC_DISABLE_POISONING': '1', 17:17:08 INFO - 'LANG': 'en_US.UTF-8', 17:17:08 INFO - 'LANGUAGE': 'en_US:en', 17:17:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:17:08 INFO - 'LOGNAME': 'cltbld', 17:17:08 INFO - 'MAIL': '/var/mail/cltbld', 17:17:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:17:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:17:08 INFO - 'MOZ_CRASHREPORTER': '1', 17:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:17:08 INFO - 'MOZ_NO_REMOTE': '1', 17:17:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:08 INFO - 'NO_EM_RESTART': '1', 17:17:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:08 INFO - 'PWD': '/builds/slave/test', 17:17:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:17:08 INFO - 'RUST_BACKTRACE': 'full', 17:17:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:17:08 INFO - 'SHELL': '/bin/bash', 17:17:08 INFO - 'SHLVL': '1', 17:17:08 INFO - 'STYLO_FORCE_ENABLED': '1', 17:17:08 INFO - 'STYLO_THREADS': '1', 17:17:08 INFO - 'TERM': 'linux', 17:17:08 INFO - 'TMOUT': '86400', 17:17:08 INFO - 'USER': 'cltbld', 17:17:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:08 INFO - '_': '/tools/buildbot/bin/python'} 17:17:08 INFO - TEST-INFO | started process 24149 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_VsjLv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:09 INFO - PID 24149 | 17:17:09 INFO - PID 24149 | (/builds/slave/test/build/application/firefox/firefox:24200): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:17:09 INFO - PID 24149 | 17:17:20 INFO - PID 24149 | RSS: Main: 173584384 17:17:20 INFO - PID 24149 | 17:20:19 INFO - PID 24149 | Cycle 1(1): loaded http://localhost:57104/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57104/tests/dromaeo/cssquery-ext.html) 17:20:20 INFO - PID 24149 | RSS: Main: 175075328 17:20:20 INFO - PID 24149 | 17:23:22 INFO - PID 24149 | Cycle 1(1): loaded http://localhost:57104/tests/dromaeo/cssquery-ext.html (next: http://localhost:57104/tests/dromaeo/cssquery-jquery.html) 17:23:22 INFO - PID 24149 | RSS: Main: 169668608 17:23:22 INFO - PID 24149 | 17:26:24 INFO - PID 24149 | Cycle 1(1): loaded http://localhost:57104/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57104/tests/dromaeo/cssquery-mootools.html) 17:26:25 INFO - PID 24149 | RSS: Main: 174055424 17:26:25 INFO - PID 24149 | 17:29:26 INFO - PID 24149 | Cycle 1(1): loaded http://localhost:57104/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57104/tests/dromaeo/cssquery-prototype.html) 17:29:27 INFO - PID 24149 | RSS: Main: 172072960 17:29:27 INFO - PID 24149 | 17:32:31 INFO - PID 24149 | Cycle 1(1): loaded http://localhost:57104/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57104/tests/dromaeo/cssquery-yui.html) 17:32:31 INFO - PID 24149 | RSS: Main: 173592576 17:32:31 INFO - PID 24149 | 17:35:33 INFO - PID 24149 | Cycle 1(1): loaded http://localhost:57104/tests/dromaeo/cssquery-yui.html (next: http://localhost:57104/tests/dromaeo/cssquery-dojo.html) 17:35:33 INFO - PID 24149 | RSS: Main: 176054272 17:35:33 INFO - PID 24149 | 17:35:33 INFO - PID 24149 | __start_tp_report 17:35:33 INFO - PID 24149 | _x_x_mozilla_page_load 17:35:33 INFO - PID 24149 | _x_x_mozilla_page_load_details 17:35:33 INFO - PID 24149 | |i|pagename|runs| 17:35:33 INFO - PID 24149 | |0;dojo.html;3317.336532693462;3354.781939173955;3364.5289659447676;3374.6287908330087;3408.60801007884;6332.1768170137875;6371.331010243927;6435.678216089189;6497.415232629062;6540.345965403457;6242.937570624293;6420.518461115424;6423.100765892767;6434.388733070363;6460.450861676763;5835.183074369581;5866.413358664121;5904.0553511437965;5994.46049855513;6029.5176385889245;6014.51883849291;6027.638341699512;6035.366286539916;6036.667983260919;6044.335123136451;5836.5914385993;5912.467877890989;5958.28500579931;6028.879422411549;6041.154238406627;5974.820755377345;5976.133460648181;5994.310654274727;6017.669028203447;6035.7585696572305;5691.345495268014;5762.769489220426;5791.160281759121;5884;5958.821235362946;6333.68331583419;6409.327020662857;6410;6425.357464253584;6432.807015789487;6923.307669233087;6926.064981227521;6932.029515867783;6935.618540980244;6936.306369363074;6928.653567321664;6947.235804061549;6953.130858642669;7034.2262351141335;7043.577385356895;6188.96905515474;6356.4279214870885;6431.935680643227;6441.5490915635455;6548.8035358939305;7187.460940429384;7233.493655444068;7244.058272424656;7257.709691612382;7281.381082608038;6832.658367081626;6906.171259448898;6933.618650974245;6938.340857618518;6938.8612227756175;6967;6969.4424446044195;6995.965020174866;7067.43460523157;7090.822729431702;6657.1345725055435;6752;6844.21291551468;6913.308669133046;6919.861602767916;6864.073350097773;6865.519413640997;6884.931150688429;6935.895961560581;6936.410405115622;5391.056565101092;5401.3518377794135;5468.398476167618;5471.699056551928;5475.534579560703;4667.649926255544;4718.386609740781;4726.172919739032;4775.689580177277;4797.64017698674;5999.7900073498095;6033.064874944391;6059.6364218147055;6063.696815159225;6065.878682426327;6932.168139823253;6987.965060174666;7011.754588589375;7021.1574611047;7024.192217894905;5922.644641321534;5975.671338076448;6040.365761595057;6086.02623580225;6088.056351265561;5781.306243250837;5893.233879595625;5933.169356290123;5982.611130276605;5996.610220335664;6602.141721576164;6666.866662666719;6679.365460281266;6693.895507241251;6822.113125293779;6846.110005699227;6907.965460172667;6991.650417479004;7011.404030657247;7015.894761578683;6415;6630.9668451657435;6670.966645166937;6709.094272273181;6759.594424334556;6775.966120169368;6867.759628412981;6877.105976223059;6948.6525673715105;6956.373926346653;6974.19796723363;7046.577205367695;7053.047838541731;7062.046623705939;7091.042709234187;6518.185226846645;6669.0663307136065;6676.833079172865;6688.899666505104;6712.798616041527;6631.33686631333;6641.070250165078;6767;6779;6802.591844489347;6670.633115178712;6704.564203326768;6763.5603685762235;6771.052052712525;6774.254831968578;6797.048413222054;6801.863962720817;6850.8972365413565;6888.173419189729;6920.5847649141215;6368.617882926854;6435.51733619971;6446.967765161145;6466.579672321284;6599.8020059398295 17:35:33 INFO - PID 24149 | |1;ext.html;812.1918690902553;828.2587084559316;852.2840813716477;877.7059685005523;878.3895192840974;40591.18817623646;41388.58611413885;41490.58509414905;41576;41582.16835663285;36726.265474690554;36937;36947.26105477896;36953.44569831455;37023.44464833023;6899.931000689979;7016.508844380895;7043.929560704404;7045.154581450233;7045.753398631049;6905.309469053104;6945.548539344926;6946.861062778767;6948.5830850148905;6954;7621.771346859603;7856.292933635971;7858.1356050834365;7862.960685196566;7864.921350786505;7741.57421341826;7818.14000459949;7822.37421006321;7822.726204582812;7824.256695613907;7480.476366654337;7660.616969151576;7677.923220767777;7683.0780306363595;7701.499402538817;37650.43524347137;37653.62346376529;37973.24053518942;38048.23903521914;38052.429213561816;3594.9101272468138;3635.5455568053994;3644.489771432002;3644.7266455015715;3645;30947.381052379053;31004.914827980912;31077;31136;31158.844205778827;5168.069747445458;5187.455317191716;5192.662476938987;5213.165893457067;5216.347956505437;172306;174379;183127;185062;190487.9999999986;48115.75942120267;48272.27591586129;48446.75776621094;48483.515164848606;48654.75672621614;50980.49019509832;51021;51092;51338.48661513412;51357.48642513602;14697.191654459108;14787.926060369844;14799.63000924964;14835.925820371045;14985.700285994219;12013.099017573717;12129.575464858688;12161.148719589544;12196.146269761031;12206.755864882653;13665;13766.93116534411;13861.445542178402;13872.791908121386;13973.720525589431;5483.243977875169;5537.280153580009;5576.1356989666665;5601;5682.119271512922;1007.8185926533295;1015.8882522922472;1018.7147598672384;1024.2267088348399;1032.2052019944601;22826.201082962016;23032;23118.075276989068;23300.41748956256;23356.416089597897;1093.9398333091597;1108.5510368300852;1110.1507346879644;1110.5446766825562;1114.7213196700825;12072.758544829054;12222;12246.265224086583;12342;12368.628941131781;218306;219351;219690;219742;220329;53539.464605353445;53685.731571341894;53738;53800.46199537955;54030.729846350514;1418.6027912184397;1441.0345068803927;1446.9710605787825;1450.8694217520685;1452.8111345525226;23026.654600180675;23055;23188.420289492897;23246.76753232446;23817.166399175945;37332.06669833276;37427.06432339214;37455.81272093622;37535.62464375321;37602.24795504129;185725;187046;187730;187740;187915;34031.659683402846;36204.27591448103;37051.444228336055;37084.81457592803;37099.25801483901;45152.774236129924;46073.76963115163;46131.53868461272;46231.53768462272;47509.52490475051;34689.65310346965;34721.826390867885;34726.9581912543;34769.47845782366;35257;33775.49336759902;34003;34053.148671283416;34081.48877766786;34435.311293773484;38027.42958855564;38030.61969380381;38348.61651383562;38384;38397.424038638885;32847;33201.66798331986;33217.667823321455;33367;33530.32939341248;23982.160624378062;24858.627120593566;25026.499470010862;25064.749352506242;25678.61482077733 17:35:33 INFO - PID 24149 | |2;jquery.html;565.7312776431196;574.1846577859441;574.9494809070101;579.3395529096833;588.8468998060505;18866.528336791587;19223;19240.80759192406;19293.807061929376;19415.02924853755;24168.51662966744;25329.2401227963;26569.468610627777;26642;26716;6549.607023578588;6701.832454188636;6706.731730730765;6708.49686273529;6723.798286051427;6397.680115994205;6609.768658096968;6656.201255849305;6656.534042617019;6753.763618273361;6698.363655452724;6701.363370479821;6712.060311556386;6715.160604924385;6718.697658605374;6673.599584024974;6703.262641109474;6704.631245281507;6708.698108585126;6715.160604924385;6220.066989951498;6223.066540018988;6223.719932602999;6227.470664993481;6227.968860155715;26996;27329.863350683318;27774.3056423589;27887.16338509848;28299.85850070757;2013.788552202027;2064.225915281769;2071.9171233150655;2072.9481762955897;2076.09689784944;19424.611507769907;19439.902800485906;19834.404967850987;19863.304784332624;19915.601687966304;2443.706755189389;2458.139651122111;2494.550980823451;2496.7378425265447;2504.1235567551394;125661.37169314186;130480.34759826235;130868.34565827205;132360.33819830936;132361;14297;14411.63970900715;14556.272186390637;14990.325435355435;15225;22902.198423055448;22933.541329173324;22975.42561435944;23035.07859685594;23038.30885073417;9267.629294828266;9428.481433521221;9436.528173591292;9567.138957493858;9615.182709469633;7580.3556697680215;8512.616932238065;8612.78468038304;8630.482171069756;8695.608697608623;7819.843603127905;9051.637934482678;9138.908610913939;9203;9313.348065635477;2547.1721690450677;2657.3622330640505;2665.7067722550505;2734.769353790802;2760.8619569021466;810.5177419435427;836.2682652678906;843.6414523827349;843.8312337532518;845.5053793530731;17979.190936407893;22926.885365573064;24091.03635854581;24850.254492365257;25263;1020.7703266764919;1028.1055481730941;1034.7826956339254;1042.4683411460057;1051.7370657335666;11322.433878306052;11498.59754908591;11536.365499897585;11597.478113484913;11712.180147389601;474912;478662;535804;539342;546790;115649;117409;119942.400287998;122400.38799805944;122628;1191.243560339191;1224.4638072987887;1238.962831115086;1241.9689507762198;1250.2748405924542;21071;21387.8930605346;21447.356579302646;21609.891950540146;21716.891415543454;58488.707556461944;58844.41155588561;59319.40680593311;60602;60976.69511652413;75892;76378;78815.21184788078;80230;80268.19731802841;12062;12425.254484730945;12836.294003829878;14377.640558985691;14775;21159.25942592002;21269.255576054762;21339.78660213378;21384.572308554052;22556.661650074933;18703.345382912077;18721.53196170107;18722.71915921235;18889.811101888805;18918.243270269035;16633.750493742846;16839.831601683825;17171.828281717524;17472;17477;18848.151833167267;19011.619767604294;19017.049147542843;19046.952417617165;19227.51931201731;14053.156810591398;14576.635584110481;14603.415863365346;14758.450362711761;14901.329440175436;18762.249510019446;18848.24607015704;18899.811001890354;18919.43241702751;18933.810661893203 17:35:33 INFO - PID 24149 | |3;mootools.html;1298.4481595321988;1341.5438750824717;1365.2218235605706;1372.4715984346037;1377.3664114507326;14832.332545035473;15174.165420901845;15425.768613470807;15454.304556294966;15461;15179.16514591697;16050.59873503163;16056.678866422693;16085;16116;2669.9599506007426;2722.8502432366213;2723.9591406128925;2724.8637568121612;2729.385888175155;2670.5727083666616;2749.037836757129;2749.845065072664;2752.7109653486295;2757.4485102979384;2703.8918443262346;2725.4140359822636;2729.549624311986;2732.398872248112;2737.685166205892;2540.809439292051;2563.51293254282;2586.663733714605;2587.573050446674;2597.2078516052597;2615.1108623068058;2634.565296726038;2640.3003204150723;2643.70919198888;2644.576867701159;14739.189344586044;14996;15025.549233523012;15029.774553381709;15033.548993530212;7304.342609165201;7546.2831031051965;7582.317591416799;7583.696652133908;7584.886226706604;4983.700977941335;5097.9490205097845;5118.872028199325;5199.558037566773;5209.322788037531;1939.8254157125784;1942.0872190070645;1945.1733013469361;1948.6200190962768;1985.434151266882;26157.73842261572;26290.73709262902;26293.34266643349;26327.47345053088;26404.73595264042;6830.829229269308;6868.313168683092;6878;7036.683349249296;7077.292270772881;17206.31174752996;17206.655866882593;17243.3964811231;17255.82744172542;17264.395746148824;7471.925280747123;7722.189170137167;7740.032495938008;7740.225977402215;7740.303372696484;5856.472917437366;6819;6864.7940561783225;6870.038194652752;7130.964345178241;5237.73811309433;5326.147816349443;5326.840194794162;5351.9464805351445;5390.9191362129595;1474.823021237437;1481.6073740458787;1487.5983484459136;1490.8285547162216;1508.7058023685277;902.2871931174299;914.1772404835568;921.6405601815297;929.4748467116058;934.9672761453317;7752;7775.1447340792465;7781.45529812919;7839.804004899809;7942.841143177104;700.1661661957814;712.3161764705836;725.3979197266257;735.63586024918;745.2137994415943;4795.928061079087;5025.723585202776;5397.136458166675;5443.101888188484;5488.4785945335125;20507;20910.895445522674;21339.35981920514;21772.891135544538;22185.556288874453;20794.584108317747;21302.467438314165;21550.78449215488;21555.353339399844;21608.675869861963;10269.589216431259;10576.629817956335;10598.36409815429;10617.309874858109;10639.41483218415;8208;8264.21489958453;8323.750287491384;8353.122922093336;8426.241638252586;18285.817141828942;18412.447626571226;18640.627187456445;18895.05524723731;18967.05164741785;18994.240230391184;19022.524436888634;19047.809521905157;19059.809401905804;19134.94757788335;9197.21823644971;9473.857892131762;11186.049185819296;11241.606543771255;11418.371989540656;14096;14209.431622735388;14228.715425691222;14241.287935602972;14244.287785610471;11332.830007549728;11499.425028748696;11504.25222360544;11610.6516804496;11729.296242225493;10988.615398461016;11020.724481888017;11029.172812039289;11068.28056176346;11254;10109.03964123407;10304.124149447382;10305.484725763532;10309.48452577353;10317.380957142595;7272.272772722897;7296.379807716404;7321.414286857145;7462.253774622494;7529.58587277705;7720;7765.145833958147;7778.222177782177;7786.883196752166;7803.219678032151 17:35:33 INFO - PID 24149 | |4;prototype.html;504.73753648102985;506.8808829924967;531.29868573483;533.8745394832214;538.51264605532;6410.96794516028;6423.454006409455;6461.160049193598;6484.22189337279;6519.315471875456;6177.907331390033;6244.375562443754;6291.496680265579;6311.715972781224;6328.778492752755;5075.695458272516;5076.543111119999;5126.7436628168625;5143.331366922295;5168.819091331804;4974.403071631409;5067.619928505358;5073.568746656539;5140.7172605506685;5167.199084141964;5038.899222015558;5056.8482945511505;5068.923966140511;5079.822206222783;5105.566026887719;5122.795088196468;5125.360439373707;5131.846044618667;5145.716985565792;5163.967206558666;4543.931841022388;4546.52261512543;4549.704269222523;4578.2903649934315;4588.449386073659;6243.313235544132;6252.687365631746;6306.779262725829;6314.400131987454;6345.525245154347;5897.380775018604;5897.764089436418;5900.321463031721;5913.852153696192;5918.763249470016;6735.764248251287;6755.189377274709;6758.459323254128;6766.966165169192;6773.864522709568;4959.396316933603;4973.676711013773;4974.577160941324;4974.850754477371;4997.975010124963;7063.081799366049;7119.359257666783;7178.389836863873;7228.674709638026;7248.492605517563;5099.413567439718;5101.489851014869;5109.412417572027;5142.331496905378;5154.742262886841;5138.511841375063;5181.844544663591;5231.921521177185;5233.738313084331;5250.317458730341;5854.121881717691;5863.706814659336;5884.911726324109;5886.0288052471715;5916.171735956969;6693.820435293294;6724.495662825308;6746.797596072126;6818.829529261808;6882.589069240794;1651.149657926169;1727.2831774813562;1869.9252029918923;1956.7456230690204;1964.9683915943958;1409.2249262905361;1413.236852099875;1444.7399468095844;1447.8055604126637;1476.2323591732238;5753.712314384264;5876.882462350729;5886.764529418861;5922.437368449991;5956.255468066492;6719.08506075766;6813.2846051163915;6824.897626535606;6898.586084834926;6930.688119034656;5789.363170051291;5813.59304848665;5872.207252020922;5893.116032595145;5995.190649262294;3600.981995090008;3630.618785027587;3663.19409729859;3673.9632603674154;3687.94468082979;6598.878190707591;6617.94112941927;6629.5359324846795;6654.567453115532;6676;7100;7171.748988785367;7214.114354258234;7237.565746055254;7247.383972362408;6572.737090516326;6631.23740769808;6665.433438157811;6685.164354455693;6685.39831415175;6907.585544867324;6937.340952609494;6951.20061192949;6957.373836354753;6991;6872.793816185523;6876.896846547205;6956.756513522002;6994.895076573957;7015;6577.506686998398;6594.604323740591;6604.438622717123;6613.66931653425;6648.867022659617;4980.452150263541;4993.350864387607;5000.449950505515;5026.748662566784;5035.697858128524;6699.263081061177;6875.518713689994;6876.140482439695;6903.447724181953;6918.481113916376;6536.607803531803;6546.705398256994;6651.46788256948;6653.63405012729;6684.398404143651;6567.211934567691;6620.801375958729;6639.3692599203;6662.933370666231;6710.966445167743;6420.871582568416;6468.126802881551;6475.222973243052;6600.933990660032;6663.967085101817;6659.467242620675;6670.331867253138;6754;6784.7964561063245;6788;6440.42036216724;6478.805635830932;6540.705668245036;6559.8032059038305;6605.405513503808 17:35:33 INFO - PID 24149 | |5;yui.html;844.5903736687706;876.3733930239886;887.4719541872583;888.2405543260513;913.6710784117716;17265.223064962076;18058.72911906319;18070.186841592127;18129.728054079165;20425.28511502098;19967.60064798703;20514;20832.68750968733;20904.37286881396;21040.57918841626;972.8832540095199;974.3228456222928;977.4135518688801;977.8288799460101;978.6183388478463;965.4979410706428;1003.9749006274865;1006.099540910888;1007.1791489935679;1008.0625018732576;1049.732318258843;1057.1912486947454;1058;1059.4914441068292;1060.7666313411037;1043.598214687347;1045.2108657963265;1045.2735348932495;1045.9947700261525;1047.748540350318;770.1682183242085;770.7841804294807;771.5833449937028;773.6247919758913;776.0454640791801;18533.721994170097;18708;18861.905690471598;18914.24343026291;19422.320218792414;20792.48018799527;20982.580348393098;21401.785982140136;21460.356189314345;21494;12314.13801033928;12338.444769985372;12367.07246956473;12446.25322480645;12486.81269780954;3647.3799454092605;3708.313961917027;3761.4545890845675;3781.3949768037255;3783.7540559863796;121056;122168.72409465627;122242;123871.3806430971;124448;16439.342426303054;16781.24484398205;16810.41163559294;16905;16949.661006779796;30234.84882575573;31030.844845775628;31324;31391.37217255642;31419.214519637193;8649.870251946226;8656.567171641393;8803.339749518811;8864.468131912106;8866.733997979942;3856.9807150964066;3903.6291552302487;3903.726739128234;3923.391874259494;3936.4488971544006;4801.591864691471;4901.681390709664;4908.214685650279;4936.3829521309835;4946.505349465025;916.2212119698337;917.3624331089828;934.3506263147048;937.6015193542853;939.9436033837854;680.1667956753037;701.225146213437;703.2756261051126;717.5730440387961;719.989200161998;11429.314241145392;11718.296902185726;11955.701107472383;12050.578229761917;12474.937625311815;665.9567128136656;669.0499490723184;677.695037233247;677.8644271145691;692.6571347183177;5409.323834520685;5590.273264475592;5661.433856614388;5724.1413787931315;5986.311574168939;108788.4560577192;108986;109937;110258;110532;93525.53237233906;97207;99017;100600;101412;86408.703869442;86687.56656216679;87605.561972191;88871.55564222267;89915.55042224747;10791.784164316827;10946.39794811293;10973.122150228122;11052.834207487054;11171.106311495223;31703.84148079245;39626.60373396229;41666;42373.36439953341;42641.57358426376;70251.64874175597;70744;73100;74680;75986;18031.459056228334;18839.529011774266;19124.043797809776;19152.80847191566;19279.22883084717;20613.793862061186;20793.89603051975;21033.684494732897;21211.7878821216;21633.13467461284;18919.337823176123;19407.2237110514;19490.90254548718;19522.121504532613;19601.411957641292;17560.56098597545;17791.911040445233;17940.282388704305;18639.254429822657;19467.51331216731;18363.449096527125;18462.261509540007;18686.15912283923;18937.621247575247;19137.234510619975;12573.308468034345;12575.056870734548;12634.178778379375;12732.554360597334;12934.870651293366;13626.182429054288;13667.384967676677;13729.588112356645;13810.309484525935;14385.496507622183 17:35:33 INFO - PID 24149 | __end_tp_report 17:35:33 INFO - PID 24149 | __start_cc_report 17:35:33 INFO - PID 24149 | _x_x_mozilla_cycle_collect,365 17:35:33 INFO - PID 24149 | __end_cc_report 17:35:33 INFO - PID 24149 | __startTimestamp1504312533829__endTimestamp 17:35:33 INFO - PID 24149 | 17:35:33 INFO - PID 24149 | ------- Summary: start ------- 17:35:33 INFO - PID 24149 | Number of tests: 6 17:35:33 INFO - PID 24149 | 17:35:33 INFO - PID 24149 | [#0] dojo.html Cycles:165 Average:6373.35 Median:6602.14 stddev:759.25 (11.5%) stddev-sans-first:722.74 17:35:33 INFO - PID 24149 | Values: 3317.3 3354.8 3364.5 3374.6 3408.6 6332.2 6371.3 6435.7 6497.4 6540.3 6242.9 6420.5 6423.1 6434.4 6460.5 5835.2 5866.4 5904.1 5994.5 6029.5 6014.5 6027.6 6035.4 6036.7 6044.3 5836.6 5912.5 5958.3 6028.9 6041.2 5974.8 5976.1 5994.3 6017.7 6035.8 5691.3 5762.8 5791.2 5884.0 5958.8 6333.7 6409.3 6410.0 6425.4 6432.8 6923.3 6926.1 6932.0 6935.6 6936.3 6928.7 6947.2 6953.1 7034.2 7043.6 6189.0 6356.4 6431.9 6441.5 6548.8 7187.5 7233.5 7244.1 7257.7 7281.4 6832.7 6906.2 6933.6 6938.3 6938.9 6967.0 6969.4 6996.0 7067.4 7090.8 6657.1 6752.0 6844.2 6913.3 6919.9 6864.1 6865.5 6884.9 6935.9 6936.4 5391.1 5401.4 5468.4 5471.7 5475.5 4667.6 4718.4 4726.2 4775.7 4797.6 5999.8 6033.1 6059.6 6063.7 6065.9 6932.2 6988.0 7011.8 7021.2 7024.2 5922.6 5975.7 6040.4 6086.0 6088.1 5781.3 5893.2 5933.2 5982.6 5996.6 6602.1 6666.9 6679.4 6693.9 6822.1 6846.1 6908.0 6991.7 7011.4 7015.9 6415.0 6631.0 6671.0 6709.1 6759.6 6776.0 6867.8 6877.1 6948.7 6956.4 6974.2 7046.6 7053.0 7062.0 7091.0 6518.2 6669.1 6676.8 6688.9 6712.8 6631.3 6641.1 6767.0 6779.0 6802.6 6670.6 6704.6 6763.6 6771.1 6774.3 6797.0 6801.9 6850.9 6888.2 6920.6 6368.6 6435.5 6447.0 6466.6 6599.8 17:35:33 INFO - PID 24149 | 17:35:33 INFO - PID 24149 | [#1] ext.html Cycles:180 Average:36917.49 Median:3644.86 stddev:50935.05 (1397.4%) stddev-sans-first:51005.79 17:35:33 INFO - PID 24149 | Values: 812.2 828.3 852.3 877.7 878.4 40591.2 41388.6 41490.6 41576.0 41582.2 36726.3 36937.0 36947.3 36953.4 37023.4 6899.9 7016.5 7043.9 7045.2 7045.8 6905.3 6945.5 6946.9 6948.6 6954.0 7621.8 7856.3 7858.1 7863.0 7864.9 7741.6 7818.1 7822.4 7822.7 7824.3 7480.5 7660.6 7677.9 7683.1 7701.5 37650.4 37653.6 37973.2 38048.2 38052.4 3594.9 3635.5 3644.5 3644.7 3645.0 30947.4 31004.9 31077.0 31136.0 31158.8 5168.1 5187.5 5192.7 5213.2 5216.3 172306.0 174379.0 183127.0 185062.0 190488.0 48115.8 48272.3 48446.8 48483.5 48654.8 50980.5 51021.0 51092.0 51338.5 51357.5 14697.2 14787.9 14799.6 14835.9 14985.7 12013.1 12129.6 12161.1 12196.1 12206.8 13665.0 13766.9 13861.4 13872.8 13973.7 5483.2 5537.3 5576.1 5601.0 5682.1 1007.8 1015.9 1018.7 1024.2 1032.2 22826.2 23032.0 23118.1 23300.4 23356.4 1093.9 1108.6 1110.2 1110.5 1114.7 12072.8 12222.0 12246.3 12342.0 12368.6 218306.0 219351.0 219690.0 219742.0 220329.0 53539.5 53685.7 53738.0 53800.5 54030.7 1418.6 1441.0 1447.0 1450.9 1452.8 23026.7 23055.0 23188.4 23246.8 23817.2 37332.1 37427.1 37455.8 37535.6 37602.2 185725.0 187046.0 187730.0 187740.0 187915.0 34031.7 36204.3 37051.4 37084.8 37099.3 45152.8 46073.8 46131.5 46231.5 47509.5 34689.7 34721.8 34727.0 34769.5 35257.0 33775.5 34003.0 34053.1 34081.5 34435.3 38027.4 38030.6 38348.6 38384.0 38397.4 32847.0 33201.7 33217.7 33367.0 33530.3 23982.2 24858.6 25026.5 25064.7 25678.6 17:35:33 INFO - PID 24149 | 17:35:33 INFO - PID 24149 | [#2] jquery.html Cycles:180 Average:35637.74 Median:23036.69 stddev:86581.70 (375.8%) stddev-sans-first:86784.54 17:35:33 INFO - PID 24149 | Values: 565.7 574.2 574.9 579.3 588.8 18866.5 19223.0 19240.8 19293.8 19415.0 24168.5 25329.2 26569.5 26642.0 26716.0 6549.6 6701.8 6706.7 6708.5 6723.8 6397.7 6609.8 6656.2 6656.5 6753.8 6698.4 6701.4 6712.1 6715.2 6718.7 6673.6 6703.3 6704.6 6708.7 6715.2 6220.1 6223.1 6223.7 6227.5 6228.0 26996.0 27329.9 27774.3 27887.2 28299.9 2013.8 2064.2 2071.9 2072.9 2076.1 19424.6 19439.9 19834.4 19863.3 19915.6 2443.7 2458.1 2494.6 2496.7 2504.1 125661.4 130480.3 130868.3 132360.3 132361.0 14297.0 14411.6 14556.3 14990.3 15225.0 22902.2 22933.5 22975.4 23035.1 23038.3 9267.6 9428.5 9436.5 9567.1 9615.2 7580.4 8512.6 8612.8 8630.5 8695.6 7819.8 9051.6 9138.9 9203.0 9313.3 2547.2 2657.4 2665.7 2734.8 2760.9 810.5 836.3 843.6 843.8 845.5 17979.2 22926.9 24091.0 24850.3 25263.0 1020.8 1028.1 1034.8 1042.5 1051.7 11322.4 11498.6 11536.4 11597.5 11712.2 474912.0 478662.0 535804.0 539342.0 546790.0 115649.0 117409.0 119942.4 122400.4 122628.0 1191.2 1224.5 1239.0 1242.0 1250.3 21071.0 21387.9 21447.4 21609.9 21716.9 58488.7 58844.4 59319.4 60602.0 60976.7 75892.0 76378.0 78815.2 80230.0 80268.2 12062.0 12425.3 12836.3 14377.6 14775.0 21159.3 21269.3 21339.8 21384.6 22556.7 18703.3 18721.5 18722.7 18889.8 18918.2 16633.8 16839.8 17171.8 17472.0 17477.0 18848.2 19011.6 19017.0 19047.0 19227.5 14053.2 14576.6 14603.4 14758.5 14901.3 18762.2 18848.2 18899.8 18919.4 18933.8 17:35:33 INFO - PID 24149 | 17:35:33 INFO - PID 24149 | [#3] mootools.html Cycles:180 Average:9272.65 Median:26292.04 stddev:6669.40 (25.4%) stddev-sans-first:6661.19 17:35:33 INFO - PID 24149 | Values: 1298.4 1341.5 1365.2 1372.5 1377.4 14832.3 15174.2 15425.8 15454.3 15461.0 15179.2 16050.6 16056.7 16085.0 16116.0 2670.0 2722.9 2724.0 2724.9 2729.4 2670.6 2749.0 2749.8 2752.7 2757.4 2703.9 2725.4 2729.5 2732.4 2737.7 2540.8 2563.5 2586.7 2587.6 2597.2 2615.1 2634.6 2640.3 2643.7 2644.6 14739.2 14996.0 15025.5 15029.8 15033.5 7304.3 7546.3 7582.3 7583.7 7584.9 4983.7 5097.9 5118.9 5199.6 5209.3 1939.8 1942.1 1945.2 1948.6 1985.4 26157.7 26290.7 26293.3 26327.5 26404.7 6830.8 6868.3 6878.0 7036.7 7077.3 17206.3 17206.7 17243.4 17255.8 17264.4 7471.9 7722.2 7740.0 7740.2 7740.3 5856.5 6819.0 6864.8 6870.0 7131.0 5237.7 5326.1 5326.8 5351.9 5390.9 1474.8 1481.6 1487.6 1490.8 1508.7 902.3 914.2 921.6 929.5 935.0 7752.0 7775.1 7781.5 7839.8 7942.8 700.2 712.3 725.4 735.6 745.2 4795.9 5025.7 5397.1 5443.1 5488.5 20507.0 20910.9 21339.4 21772.9 22185.6 20794.6 21302.5 21550.8 21555.4 21608.7 10269.6 10576.6 10598.4 10617.3 10639.4 8208.0 8264.2 8323.8 8353.1 8426.2 18285.8 18412.4 18640.6 18895.1 18967.1 18994.2 19022.5 19047.8 19059.8 19134.9 9197.2 9473.9 11186.0 11241.6 11418.4 14096.0 14209.4 14228.7 14241.3 14244.3 11332.8 11499.4 11504.3 11610.7 11729.3 10988.6 11020.7 11029.2 11068.3 11254.0 10109.0 10304.1 10305.5 10309.5 10317.4 7272.3 7296.4 7321.4 7462.3 7529.6 7720.0 7765.1 7778.2 7786.9 7803.2 17:35:33 INFO - PID 24149 | 17:35:33 INFO - PID 24149 | [#4] prototype.html Cycles:180 Average:5658.28 Median:6309.25 stddev:1576.47 (25.0%) stddev-sans-first:1532.71 17:35:33 INFO - PID 24149 | Values: 504.7 506.9 531.3 533.9 538.5 6411.0 6423.5 6461.2 6484.2 6519.3 6177.9 6244.4 6291.5 6311.7 6328.8 5075.7 5076.5 5126.7 5143.3 5168.8 4974.4 5067.6 5073.6 5140.7 5167.2 5038.9 5056.8 5068.9 5079.8 5105.6 5122.8 5125.4 5131.8 5145.7 5164.0 4543.9 4546.5 4549.7 4578.3 4588.4 6243.3 6252.7 6306.8 6314.4 6345.5 5897.4 5897.8 5900.3 5913.9 5918.8 6735.8 6755.2 6758.5 6767.0 6773.9 4959.4 4973.7 4974.6 4974.9 4998.0 7063.1 7119.4 7178.4 7228.7 7248.5 5099.4 5101.5 5109.4 5142.3 5154.7 5138.5 5181.8 5231.9 5233.7 5250.3 5854.1 5863.7 5884.9 5886.0 5916.2 6693.8 6724.5 6746.8 6818.8 6882.6 1651.1 1727.3 1869.9 1956.7 1965.0 1409.2 1413.2 1444.7 1447.8 1476.2 5753.7 5876.9 5886.8 5922.4 5956.3 6719.1 6813.3 6824.9 6898.6 6930.7 5789.4 5813.6 5872.2 5893.1 5995.2 3601.0 3630.6 3663.2 3674.0 3687.9 6598.9 6617.9 6629.5 6654.6 6676.0 7100.0 7171.7 7214.1 7237.6 7247.4 6572.7 6631.2 6665.4 6685.2 6685.4 6907.6 6937.3 6951.2 6957.4 6991.0 6872.8 6876.9 6956.8 6994.9 7015.0 6577.5 6594.6 6604.4 6613.7 6648.9 4980.5 4993.4 5000.4 5026.7 5035.7 6699.3 6875.5 6876.1 6903.4 6918.5 6536.6 6546.7 6651.5 6653.6 6684.4 6567.2 6620.8 6639.4 6662.9 6711.0 6420.9 6468.1 6475.2 6600.9 6664.0 6659.5 6670.3 6754.0 6784.8 6788.0 6440.4 6478.8 6540.7 6559.8 6605.4 17:35:33 INFO - PID 24149 | 17:35:33 INFO - PID 24149 | [#5] yui.html Cycles:180 Average:23651.80 Median:20813.29 stddev:32108.95 (154.3%) stddev-sans-first:32153.35 17:35:33 INFO - PID 24149 | Values: 844.6 876.4 887.5 888.2 913.7 17265.2 18058.7 18070.2 18129.7 20425.3 19967.6 20514.0 20832.7 20904.4 21040.6 972.9 974.3 977.4 977.8 978.6 965.5 1004.0 1006.1 1007.2 1008.1 1049.7 1057.2 1058.0 1059.5 1060.8 1043.6 1045.2 1045.3 1046.0 1047.7 770.2 770.8 771.6 773.6 776.0 18533.7 18708.0 18861.9 18914.2 19422.3 20792.5 20982.6 21401.8 21460.4 21494.0 12314.1 12338.4 12367.1 12446.3 12486.8 3647.4 3708.3 3761.5 3781.4 3783.8 121056.0 122168.7 122242.0 123871.4 124448.0 16439.3 16781.2 16810.4 16905.0 16949.7 30234.8 31030.8 31324.0 31391.4 31419.2 8649.9 8656.6 8803.3 8864.5 8866.7 3857.0 3903.6 3903.7 3923.4 3936.4 4801.6 4901.7 4908.2 4936.4 4946.5 916.2 917.4 934.4 937.6 939.9 680.2 701.2 703.3 717.6 720.0 11429.3 11718.3 11955.7 12050.6 12474.9 666.0 669.0 677.7 677.9 692.7 5409.3 5590.3 5661.4 5724.1 5986.3 108788.5 108986.0 109937.0 110258.0 110532.0 93525.5 97207.0 99017.0 100600.0 101412.0 86408.7 86687.6 87605.6 88871.6 89915.6 10791.8 10946.4 10973.1 11052.8 11171.1 31703.8 39626.6 41666.0 42373.4 42641.6 70251.6 70744.0 73100.0 74680.0 75986.0 18031.5 18839.5 19124.0 19152.8 19279.2 20613.8 20793.9 21033.7 21211.8 21633.1 18919.3 19407.2 19490.9 19522.1 19601.4 17560.6 17791.9 17940.3 18639.3 19467.5 18363.4 18462.3 18686.2 18937.6 19137.2 12573.3 12575.1 12634.2 12732.6 12934.9 13626.2 13667.4 13729.6 13810.3 14385.5 17:35:33 INFO - PID 24149 | -------- Summary: end -------- 17:35:33 INFO - PID 24149 | 17:35:34 INFO - TEST-INFO | 24149: exit 0 17:35:34 INFO - TEST-OK | dromaeo_css | took 1111249ms 17:35:34 INFO - TEST-START | kraken 17:35:34 INFO - Initialising browser for kraken test... 17:35:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57104/getInfo.html -profile /tmp/tmpAZjTTt/profile 17:35:34 INFO - TEST-INFO | started process 24523 (/builds/slave/test/build/application/firefox/firefox http://localhost:57104/getInfo.html) 17:35:39 INFO - TEST-INFO | 24523: exit 0 17:35:39 INFO - Browser initialized. 17:35:39 INFO - Running cycle 1/1 for kraken test... 17:35:39 INFO - Using env: {'DISPLAY': ':0', 17:35:39 INFO - 'HOME': '/home/cltbld', 17:35:39 INFO - 'JSGC_DISABLE_POISONING': '1', 17:35:39 INFO - 'LANG': 'en_US.UTF-8', 17:35:39 INFO - 'LANGUAGE': 'en_US:en', 17:35:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:35:39 INFO - 'LOGNAME': 'cltbld', 17:35:39 INFO - 'MAIL': '/var/mail/cltbld', 17:35:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:35:39 INFO - 'MOZ_CRASHREPORTER': '1', 17:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:35:39 INFO - 'MOZ_NO_REMOTE': '1', 17:35:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:39 INFO - 'NO_EM_RESTART': '1', 17:35:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:39 INFO - 'PWD': '/builds/slave/test', 17:35:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:39 INFO - 'RUST_BACKTRACE': 'full', 17:35:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:35:39 INFO - 'SHELL': '/bin/bash', 17:35:39 INFO - 'SHLVL': '1', 17:35:39 INFO - 'STYLO_FORCE_ENABLED': '1', 17:35:39 INFO - 'STYLO_THREADS': '1', 17:35:39 INFO - 'TERM': 'linux', 17:35:39 INFO - 'TMOUT': '86400', 17:35:39 INFO - 'USER': 'cltbld', 17:35:39 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983', 17:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:39 INFO - '_': '/tools/buildbot/bin/python'} 17:35:39 INFO - TEST-INFO | started process 24706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZjTTt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:40 INFO - PID 24706 | 17:35:40 INFO - PID 24706 | (/builds/slave/test/build/application/firefox/firefox:24757): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:35:40 INFO - PID 24706 | 17:35:50 INFO - PID 24706 | RSS: Main: 172957696 17:35:50 INFO - PID 24706 | 17:35:53 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57104/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:54 INFO - PID 24706 | RSS: Main: 178126848 17:35:54 INFO - PID 24706 | 17:35:57 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57104/tests/kraken/driver.html?testName=audio-dft) 17:35:57 INFO - PID 24706 | RSS: Main: 181964800 17:35:57 INFO - PID 24706 | 17:36:00 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57104/tests/kraken/driver.html?testName=audio-fft) 17:36:01 INFO - PID 24706 | RSS: Main: 175005696 17:36:01 INFO - PID 24706 | 17:36:03 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57104/tests/kraken/driver.html?testName=audio-oscillator) 17:36:04 INFO - PID 24706 | RSS: Main: 175218688 17:36:04 INFO - PID 24706 | 17:36:06 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57104/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:36:06 INFO - PID 24706 | RSS: Main: 175378432 17:36:06 INFO - PID 24706 | 17:36:10 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57104/tests/kraken/driver.html?testName=imaging-darkroom) 17:36:10 INFO - PID 24706 | RSS: Main: 176537600 17:36:10 INFO - PID 24706 | 17:36:14 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57104/tests/kraken/driver.html?testName=imaging-desaturate) 17:36:14 INFO - PID 24706 | RSS: Main: 176799744 17:36:14 INFO - PID 24706 | 17:36:17 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57104/tests/kraken/driver.html?testName=json-parse-financial) 17:36:18 INFO - PID 24706 | RSS: Main: 177414144 17:36:18 INFO - PID 24706 | 17:36:19 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57104/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:36:20 INFO - PID 24706 | RSS: Main: 177135616 17:36:20 INFO - PID 24706 | 17:36:22 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:36:22 INFO - PID 24706 | RSS: Main: 177496064 17:36:22 INFO - PID 24706 | 17:36:24 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:36:25 INFO - PID 24706 | RSS: Main: 174034944 17:36:25 INFO - PID 24706 | 17:36:28 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:36:28 INFO - PID 24706 | RSS: Main: 174215168 17:36:28 INFO - PID 24706 | 17:36:31 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:36:32 INFO - PID 24706 | RSS: Main: 174481408 17:36:32 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | Cycle 1(1): loaded http://localhost:57104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57104/tests/kraken/driver.html?testName=ai-astar) 17:36:34 INFO - PID 24706 | RSS: Main: 175644672 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | __start_tp_report 17:36:34 INFO - PID 24706 | _x_x_mozilla_page_load 17:36:34 INFO - PID 24706 | _x_x_mozilla_page_load_details 17:36:34 INFO - PID 24706 | |i|pagename|runs| 17:36:34 INFO - PID 24706 | |0;ai-astar;98;108;101;109;109;108;108;98;109;109 17:36:34 INFO - PID 24706 | |1;audio-beat-detection;146;114;139;178;117;149;147;116;168;116 17:36:34 INFO - PID 24706 | |2;audio-dft;163;164;161;162;161;162;166;174;165;163 17:36:34 INFO - PID 24706 | |3;audio-fft;75;74;75;161;75;74;75;93;99;75 17:36:34 INFO - PID 24706 | |4;audio-oscillator;79;79;130;79;79;78;135;79;79;129 17:36:34 INFO - PID 24706 | |5;imaging-gaussian-blur;114;114;114;114;114;119;113;113;114;114 17:36:34 INFO - PID 24706 | |6;imaging-darkroom;149;150;150;146;148;148;148;148;150;147 17:36:34 INFO - PID 24706 | |7;imaging-desaturate;95;94;94;101;98;93;94;93;93;94 17:36:34 INFO - PID 24706 | |8;json-parse-financial;52;52;51;51;51;51;52;52;52;56 17:36:34 INFO - PID 24706 | |9;json-stringify-tinderbox;38;37;38;38;37;37;37;38;39;38 17:36:34 INFO - PID 24706 | |10;stanford-crypto-aes;82;77;73;74;74;73;78;73;76;76 17:36:34 INFO - PID 24706 | |11;stanford-crypto-ccm;128;133;117;124;121;120;114;116;123;162 17:36:34 INFO - PID 24706 | |12;stanford-crypto-pbkdf2;173;170;173;168;179;171;178;171;172;173 17:36:34 INFO - PID 24706 | |13;stanford-crypto-sha256-iterative;63;65;66;64;65;66;72;64;65;63 17:36:34 INFO - PID 24706 | __end_tp_report 17:36:34 INFO - PID 24706 | __start_cc_report 17:36:34 INFO - PID 24706 | _x_x_mozilla_cycle_collect,957 17:36:34 INFO - PID 24706 | __end_cc_report 17:36:34 INFO - PID 24706 | __startTimestamp1504312594536__endTimestamp 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | ------- Summary: start ------- 17:36:34 INFO - PID 24706 | Number of tests: 14 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#0] ai-astar Cycles:10 Average:105.70 Median:109.00 stddev:4.72 (4.3%) stddev-sans-first:4.10 17:36:34 INFO - PID 24706 | Values: 98.0 108.0 101.0 109.0 109.0 108.0 108.0 98.0 109.0 109.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:146.50 stddev:22.95 (15.7%) stddev-sans-first:24.21 17:36:34 INFO - PID 24706 | Values: 146.0 114.0 139.0 178.0 117.0 149.0 147.0 116.0 168.0 116.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.84 (2.4%) stddev-sans-first:4.06 17:36:34 INFO - PID 24706 | Values: 163.0 164.0 161.0 162.0 161.0 162.0 166.0 174.0 165.0 163.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#3] audio-fft Cycles:10 Average:87.60 Median:75.00 stddev:27.31 (36.4%) stddev-sans-first:28.58 17:36:34 INFO - PID 24706 | Values: 75.0 74.0 75.0 161.0 75.0 74.0 75.0 93.0 99.0 75.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.00 stddev:25.40 (32.1%) stddev-sans-first:26.30 17:36:34 INFO - PID 24706 | Values: 79.0 79.0 130.0 79.0 79.0 78.0 135.0 79.0 79.0 129.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.70 (1.5%) stddev-sans-first:1.80 17:36:34 INFO - PID 24706 | Values: 114.0 114.0 114.0 114.0 114.0 119.0 113.0 113.0 114.0 114.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.35 (0.9%) stddev-sans-first:1.41 17:36:34 INFO - PID 24706 | Values: 149.0 150.0 150.0 146.0 148.0 148.0 148.0 148.0 150.0 147.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:2.60 (2.8%) stddev-sans-first:2.76 17:36:34 INFO - PID 24706 | Values: 95.0 94.0 94.0 101.0 98.0 93.0 94.0 93.0 93.0 94.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.49 (2.9%) stddev-sans-first:1.58 17:36:34 INFO - PID 24706 | Values: 52.0 52.0 51.0 51.0 51.0 51.0 52.0 52.0 52.0 56.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.67 (1.8%) stddev-sans-first:0.71 17:36:34 INFO - PID 24706 | Values: 38.0 37.0 38.0 38.0 37.0 37.0 37.0 38.0 39.0 38.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:76.00 stddev:2.88 (3.8%) stddev-sans-first:1.90 17:36:34 INFO - PID 24706 | Values: 82.0 77.0 73.0 74.0 74.0 73.0 78.0 73.0 76.0 76.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:123.50 stddev:13.93 (11.3%) stddev-sans-first:14.76 17:36:34 INFO - PID 24706 | Values: 128.0 133.0 117.0 124.0 121.0 120.0 114.0 116.0 123.0 162.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.00 stddev:3.39 (2.0%) stddev-sans-first:3.60 17:36:34 INFO - PID 24706 | Values: 173.0 170.0 173.0 168.0 179.0 171.0 178.0 171.0 172.0 173.0 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:2.58 (4.0%) stddev-sans-first:2.60 17:36:34 INFO - PID 24706 | Values: 63.0 65.0 66.0 64.0 65.0 66.0 72.0 64.0 65.0 63.0 17:36:34 INFO - PID 24706 | -------- Summary: end -------- 17:36:34 INFO - PID 24706 | 17:36:34 INFO - PID 24706 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:36:35 INFO - TEST-INFO | 24706: exit 0 17:36:35 INFO - TEST-OK | kraken | took 60704ms 17:36:35 INFO - SUITE-END | took 1171s 17:36:35 INFO - Completed test suite (00:19:32) 17:36:35 INFO - javascript benchmark 17:36:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8580.188337707708, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.336532693462, 3354.781939173955, 3364.5289659447676, 3374.6287908330087, 3408.60801007884, 6332.1768170137875, 6371.331010243927, 6435.678216089189, 6497.415232629062, 6540.345965403457, 6242.937570624293, 6420.518461115424, 6423.100765892767, 6434.388733070363, 6460.450861676763, 5835.183074369581, 5866.413358664121, 5904.0553511437965, 5994.46049855513, 6029.5176385889245, 6014.51883849291, 6027.638341699512, 6035.366286539916, 6036.667983260919, 6044.335123136451, 5836.5914385993, 5912.467877890989, 5958.28500579931, 6028.879422411549, 6041.154238406627, 5974.820755377345, 5976.133460648181, 5994.310654274727, 6017.669028203447, 6035.7585696572305, 5691.345495268014, 5762.769489220426, 5791.160281759121, 5884.0, 5958.821235362946, 6333.68331583419, 6409.327020662857, 6410.0, 6425.357464253584, 6432.807015789487, 6923.307669233087, 6926.064981227521, 6932.029515867783, 6935.618540980244, 6936.306369363074, 6928.653567321664, 6947.235804061549, 6953.130858642669, 7034.2262351141335, 7043.577385356895, 6188.96905515474, 6356.4279214870885, 6431.935680643227, 6441.5490915635455, 6548.8035358939305, 7187.460940429384, 7233.493655444068, 7244.058272424656, 7257.709691612382, 7281.381082608038, 6832.658367081626, 6906.171259448898, 6933.618650974245, 6938.340857618518, 6938.8612227756175, 6967.0, 6969.4424446044195, 6995.965020174866, 7067.43460523157, 7090.822729431702, 6657.1345725055435, 6752.0, 6844.21291551468, 6913.308669133046, 6919.861602767916, 6864.073350097773, 6865.519413640997, 6884.931150688429, 6935.895961560581, 6936.410405115622, 5391.056565101092, 5401.3518377794135, 5468.398476167618, 5471.699056551928, 5475.534579560703, 4667.649926255544, 4718.386609740781, 4726.172919739032, 4775.689580177277, 4797.64017698674, 5999.7900073498095, 6033.064874944391, 6059.6364218147055, 6063.696815159225, 6065.878682426327, 6932.168139823253, 6987.965060174666, 7011.754588589375, 7021.1574611047, 7024.192217894905, 5922.644641321534, 5975.671338076448, 6040.365761595057, 6086.02623580225, 6088.056351265561, 5781.306243250837, 5893.233879595625, 5933.169356290123, 5982.611130276605, 5996.610220335664, 6602.141721576164, 6666.866662666719, 6679.365460281266, 6693.895507241251, 6822.113125293779, 6846.110005699227, 6907.965460172667, 6991.650417479004, 7011.404030657247, 7015.894761578683, 6415.0, 6630.9668451657435, 6670.966645166937, 6709.094272273181, 6759.594424334556, 6775.966120169368, 6867.759628412981, 6877.105976223059, 6948.6525673715105, 6956.373926346653, 6974.19796723363, 7046.577205367695, 7053.047838541731, 7062.046623705939, 7091.042709234187, 6518.185226846645, 6669.0663307136065, 6676.833079172865, 6688.899666505104, 6712.798616041527, 6631.33686631333, 6641.070250165078, 6767.0, 6779.0, 6802.591844489347, 6670.633115178712, 6704.564203326768, 6763.5603685762235, 6771.052052712525, 6774.254831968578, 6797.048413222054, 6801.863962720817, 6850.8972365413565, 6888.173419189729, 6920.5847649141215, 6368.617882926854, 6435.51733619971, 6446.967765161145, 6466.579672321284, 6599.8020059398295], "value": 6317.20936894874, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.1918690902553, 828.2587084559316, 852.2840813716477, 877.7059685005523, 878.3895192840974, 40591.18817623646, 41388.58611413885, 41490.58509414905, 41576.0, 41582.16835663285, 36726.265474690554, 36937.0, 36947.26105477896, 36953.44569831455, 37023.44464833023, 6899.931000689979, 7016.508844380895, 7043.929560704404, 7045.154581450233, 7045.753398631049, 6905.309469053104, 6945.548539344926, 6946.861062778767, 6948.5830850148905, 6954.0, 7621.771346859603, 7856.292933635971, 7858.1356050834365, 7862.960685196566, 7864.921350786505, 7741.57421341826, 7818.14000459949, 7822.37421006321, 7822.726204582812, 7824.256695613907, 7480.476366654337, 7660.616969151576, 7677.923220767777, 7683.0780306363595, 7701.499402538817, 37650.43524347137, 37653.62346376529, 37973.24053518942, 38048.23903521914, 38052.429213561816, 3594.9101272468138, 3635.5455568053994, 3644.489771432002, 3644.7266455015715, 3645.0, 30947.381052379053, 31004.914827980912, 31077.0, 31136.0, 31158.844205778827, 5168.069747445458, 5187.455317191716, 5192.662476938987, 5213.165893457067, 5216.347956505437, 172306.0, 174379.0, 183127.0, 185062.0, 190487.9999999986, 48115.75942120267, 48272.27591586129, 48446.75776621094, 48483.515164848606, 48654.75672621614, 50980.49019509832, 51021.0, 51092.0, 51338.48661513412, 51357.48642513602, 14697.191654459108, 14787.926060369844, 14799.63000924964, 14835.925820371045, 14985.700285994219, 12013.099017573717, 12129.575464858688, 12161.148719589544, 12196.146269761031, 12206.755864882653, 13665.0, 13766.93116534411, 13861.445542178402, 13872.791908121386, 13973.720525589431, 5483.243977875169, 5537.280153580009, 5576.1356989666665, 5601.0, 5682.119271512922, 1007.8185926533295, 1015.8882522922472, 1018.7147598672384, 1024.2267088348399, 1032.2052019944601, 22826.201082962016, 23032.0, 23118.075276989068, 23300.41748956256, 23356.416089597897, 1093.9398333091597, 1108.5510368300852, 1110.1507346879644, 1110.5446766825562, 1114.7213196700825, 12072.758544829054, 12222.0, 12246.265224086583, 12342.0, 12368.628941131781, 218306.0, 219351.0, 219690.0, 219742.0, 220329.0, 53539.464605353445, 53685.731571341894, 53738.0, 53800.46199537955, 54030.729846350514, 1418.6027912184397, 1441.0345068803927, 1446.9710605787825, 1450.8694217520685, 1452.8111345525226, 23026.654600180675, 23055.0, 23188.420289492897, 23246.76753232446, 23817.166399175945, 37332.06669833276, 37427.06432339214, 37455.81272093622, 37535.62464375321, 37602.24795504129, 185725.0, 187046.0, 187730.0, 187740.0, 187915.0, 34031.659683402846, 36204.27591448103, 37051.444228336055, 37084.81457592803, 37099.25801483901, 45152.774236129924, 46073.76963115163, 46131.53868461272, 46231.53768462272, 47509.52490475051, 34689.65310346965, 34721.826390867885, 34726.9581912543, 34769.47845782366, 35257.0, 33775.49336759902, 34003.0, 34053.148671283416, 34081.48877766786, 34435.311293773484, 38027.42958855564, 38030.61969380381, 38348.61651383562, 38384.0, 38397.424038638885, 32847.0, 33201.66798331986, 33217.667823321455, 33367.0, 33530.32939341248, 23982.160624378062, 24858.627120593566, 25026.499470010862, 25064.749352506242, 25678.61482077733], "value": 17068.027496834067, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.7312776431196, 574.1846577859441, 574.9494809070101, 579.3395529096833, 588.8468998060505, 18866.528336791587, 19223.0, 19240.80759192406, 19293.807061929376, 19415.02924853755, 24168.51662966744, 25329.2401227963, 26569.468610627777, 26642.0, 26716.0, 6549.607023578588, 6701.832454188636, 6706.731730730765, 6708.49686273529, 6723.798286051427, 6397.680115994205, 6609.768658096968, 6656.201255849305, 6656.534042617019, 6753.763618273361, 6698.363655452724, 6701.363370479821, 6712.060311556386, 6715.160604924385, 6718.697658605374, 6673.599584024974, 6703.262641109474, 6704.631245281507, 6708.698108585126, 6715.160604924385, 6220.066989951498, 6223.066540018988, 6223.719932602999, 6227.470664993481, 6227.968860155715, 26996.0, 27329.863350683318, 27774.3056423589, 27887.16338509848, 28299.85850070757, 2013.788552202027, 2064.225915281769, 2071.9171233150655, 2072.9481762955897, 2076.09689784944, 19424.611507769907, 19439.902800485906, 19834.404967850987, 19863.304784332624, 19915.601687966304, 2443.706755189389, 2458.139651122111, 2494.550980823451, 2496.7378425265447, 2504.1235567551394, 125661.37169314186, 130480.34759826235, 130868.34565827205, 132360.33819830936, 132361.0, 14297.0, 14411.63970900715, 14556.272186390637, 14990.325435355435, 15225.0, 22902.198423055448, 22933.541329173324, 22975.42561435944, 23035.07859685594, 23038.30885073417, 9267.629294828266, 9428.481433521221, 9436.528173591292, 9567.138957493858, 9615.182709469633, 7580.3556697680215, 8512.616932238065, 8612.78468038304, 8630.482171069756, 8695.608697608623, 7819.843603127905, 9051.637934482678, 9138.908610913939, 9203.0, 9313.348065635477, 2547.1721690450677, 2657.3622330640505, 2665.7067722550505, 2734.769353790802, 2760.8619569021466, 810.5177419435427, 836.2682652678906, 843.6414523827349, 843.8312337532518, 845.5053793530731, 17979.190936407893, 22926.885365573064, 24091.03635854581, 24850.254492365257, 25263.0, 1020.7703266764919, 1028.1055481730941, 1034.7826956339254, 1042.4683411460057, 1051.7370657335666, 11322.433878306052, 11498.59754908591, 11536.365499897585, 11597.478113484913, 11712.180147389601, 474912.0, 478662.0, 535804.0, 539342.0, 546790.0, 115649.0, 117409.0, 119942.400287998, 122400.38799805944, 122628.0, 1191.243560339191, 1224.4638072987887, 1238.962831115086, 1241.9689507762198, 1250.2748405924542, 21071.0, 21387.8930605346, 21447.356579302646, 21609.891950540146, 21716.891415543454, 58488.707556461944, 58844.41155588561, 59319.40680593311, 60602.0, 60976.69511652413, 75892.0, 76378.0, 78815.21184788078, 80230.0, 80268.19731802841, 12062.0, 12425.254484730945, 12836.294003829878, 14377.640558985691, 14775.0, 21159.25942592002, 21269.255576054762, 21339.78660213378, 21384.572308554052, 22556.661650074933, 18703.345382912077, 18721.53196170107, 18722.71915921235, 18889.811101888805, 18918.243270269035, 16633.750493742846, 16839.831601683825, 17171.828281717524, 17472.0, 17477.0, 18848.151833167267, 19011.619767604294, 19017.049147542843, 19046.952417617165, 19227.51931201731, 14053.156810591398, 14576.635584110481, 14603.415863365346, 14758.450362711761, 14901.329440175436, 18762.249510019446, 18848.24607015704, 18899.811001890354, 18919.43241702751, 18933.810661893203], "value": 11993.395532588765, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.4481595321988, 1341.5438750824717, 1365.2218235605706, 1372.4715984346037, 1377.3664114507326, 14832.332545035473, 15174.165420901845, 15425.768613470807, 15454.304556294966, 15461.0, 15179.16514591697, 16050.59873503163, 16056.678866422693, 16085.0, 16116.0, 2669.9599506007426, 2722.8502432366213, 2723.9591406128925, 2724.8637568121612, 2729.385888175155, 2670.5727083666616, 2749.037836757129, 2749.845065072664, 2752.7109653486295, 2757.4485102979384, 2703.8918443262346, 2725.4140359822636, 2729.549624311986, 2732.398872248112, 2737.685166205892, 2540.809439292051, 2563.51293254282, 2586.663733714605, 2587.573050446674, 2597.2078516052597, 2615.1108623068058, 2634.565296726038, 2640.3003204150723, 2643.70919198888, 2644.576867701159, 14739.189344586044, 14996.0, 15025.549233523012, 15029.774553381709, 15033.548993530212, 7304.342609165201, 7546.2831031051965, 7582.317591416799, 7583.696652133908, 7584.886226706604, 4983.700977941335, 5097.9490205097845, 5118.872028199325, 5199.558037566773, 5209.322788037531, 1939.8254157125784, 1942.0872190070645, 1945.1733013469361, 1948.6200190962768, 1985.434151266882, 26157.73842261572, 26290.73709262902, 26293.34266643349, 26327.47345053088, 26404.73595264042, 6830.829229269308, 6868.313168683092, 6878.0, 7036.683349249296, 7077.292270772881, 17206.31174752996, 17206.655866882593, 17243.3964811231, 17255.82744172542, 17264.395746148824, 7471.925280747123, 7722.189170137167, 7740.032495938008, 7740.225977402215, 7740.303372696484, 5856.472917437366, 6819.0, 6864.7940561783225, 6870.038194652752, 7130.964345178241, 5237.73811309433, 5326.147816349443, 5326.840194794162, 5351.9464805351445, 5390.9191362129595, 1474.823021237437, 1481.6073740458787, 1487.5983484459136, 1490.8285547162216, 1508.7058023685277, 902.2871931174299, 914.1772404835568, 921.6405601815297, 929.4748467116058, 934.9672761453317, 7752.0, 7775.1447340792465, 7781.45529812919, 7839.804004899809, 7942.841143177104, 700.1661661957814, 712.3161764705836, 725.3979197266257, 735.63586024918, 745.2137994415943, 4795.928061079087, 5025.723585202776, 5397.136458166675, 5443.101888188484, 5488.4785945335125, 20507.0, 20910.895445522674, 21339.35981920514, 21772.891135544538, 22185.556288874453, 20794.584108317747, 21302.467438314165, 21550.78449215488, 21555.353339399844, 21608.675869861963, 10269.589216431259, 10576.629817956335, 10598.36409815429, 10617.309874858109, 10639.41483218415, 8208.0, 8264.21489958453, 8323.750287491384, 8353.122922093336, 8426.241638252586, 18285.817141828942, 18412.447626571226, 18640.627187456445, 18895.05524723731, 18967.05164741785, 18994.240230391184, 19022.524436888634, 19047.809521905157, 19059.809401905804, 19134.94757788335, 9197.21823644971, 9473.857892131762, 11186.049185819296, 11241.606543771255, 11418.371989540656, 14096.0, 14209.431622735388, 14228.715425691222, 14241.287935602972, 14244.287785610471, 11332.830007549728, 11499.425028748696, 11504.25222360544, 11610.6516804496, 11729.296242225493, 10988.615398461016, 11020.724481888017, 11029.172812039289, 11068.28056176346, 11254.0, 10109.03964123407, 10304.124149447382, 10305.484725763532, 10309.48452577353, 10317.380957142595, 7272.272772722897, 7296.379807716404, 7321.414286857145, 7462.253774622494, 7529.58587277705, 7720.0, 7765.145833958147, 7778.222177782177, 7786.883196752166, 7803.219678032151], "value": 6578.48628908302, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.73753648102985, 506.8808829924967, 531.29868573483, 533.8745394832214, 538.51264605532, 6410.96794516028, 6423.454006409455, 6461.160049193598, 6484.22189337279, 6519.315471875456, 6177.907331390033, 6244.375562443754, 6291.496680265579, 6311.715972781224, 6328.778492752755, 5075.695458272516, 5076.543111119999, 5126.7436628168625, 5143.331366922295, 5168.819091331804, 4974.403071631409, 5067.619928505358, 5073.568746656539, 5140.7172605506685, 5167.199084141964, 5038.899222015558, 5056.8482945511505, 5068.923966140511, 5079.822206222783, 5105.566026887719, 5122.795088196468, 5125.360439373707, 5131.846044618667, 5145.716985565792, 5163.967206558666, 4543.931841022388, 4546.52261512543, 4549.704269222523, 4578.2903649934315, 4588.449386073659, 6243.313235544132, 6252.687365631746, 6306.779262725829, 6314.400131987454, 6345.525245154347, 5897.380775018604, 5897.764089436418, 5900.321463031721, 5913.852153696192, 5918.763249470016, 6735.764248251287, 6755.189377274709, 6758.459323254128, 6766.966165169192, 6773.864522709568, 4959.396316933603, 4973.676711013773, 4974.577160941324, 4974.850754477371, 4997.975010124963, 7063.081799366049, 7119.359257666783, 7178.389836863873, 7228.674709638026, 7248.492605517563, 5099.413567439718, 5101.489851014869, 5109.412417572027, 5142.331496905378, 5154.742262886841, 5138.511841375063, 5181.844544663591, 5231.921521177185, 5233.738313084331, 5250.317458730341, 5854.121881717691, 5863.706814659336, 5884.911726324109, 5886.0288052471715, 5916.171735956969, 6693.820435293294, 6724.495662825308, 6746.797596072126, 6818.829529261808, 6882.589069240794, 1651.149657926169, 1727.2831774813562, 1869.9252029918923, 1956.7456230690204, 1964.9683915943958, 1409.2249262905361, 1413.236852099875, 1444.7399468095844, 1447.8055604126637, 1476.2323591732238, 5753.712314384264, 5876.882462350729, 5886.764529418861, 5922.437368449991, 5956.255468066492, 6719.08506075766, 6813.2846051163915, 6824.897626535606, 6898.586084834926, 6930.688119034656, 5789.363170051291, 5813.59304848665, 5872.207252020922, 5893.116032595145, 5995.190649262294, 3600.981995090008, 3630.618785027587, 3663.19409729859, 3673.9632603674154, 3687.94468082979, 6598.878190707591, 6617.94112941927, 6629.5359324846795, 6654.567453115532, 6676.0, 7100.0, 7171.748988785367, 7214.114354258234, 7237.565746055254, 7247.383972362408, 6572.737090516326, 6631.23740769808, 6665.433438157811, 6685.164354455693, 6685.39831415175, 6907.585544867324, 6937.340952609494, 6951.20061192949, 6957.373836354753, 6991.0, 6872.793816185523, 6876.896846547205, 6956.756513522002, 6994.895076573957, 7015.0, 6577.506686998398, 6594.604323740591, 6604.438622717123, 6613.66931653425, 6648.867022659617, 4980.452150263541, 4993.350864387607, 5000.449950505515, 5026.748662566784, 5035.697858128524, 6699.263081061177, 6875.518713689994, 6876.140482439695, 6903.447724181953, 6918.481113916376, 6536.607803531803, 6546.705398256994, 6651.46788256948, 6653.63405012729, 6684.398404143651, 6567.211934567691, 6620.801375958729, 6639.3692599203, 6662.933370666231, 6710.966445167743, 6420.871582568416, 6468.126802881551, 6475.222973243052, 6600.933990660032, 6663.967085101817, 6659.467242620675, 6670.331867253138, 6754.0, 6784.7964561063245, 6788.0, 6440.42036216724, 6478.805635830932, 6540.705668245036, 6559.8032059038305, 6605.405513503808], "value": 5205.615523542098, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [844.5903736687706, 876.3733930239886, 887.4719541872583, 888.2405543260513, 913.6710784117716, 17265.223064962076, 18058.72911906319, 18070.186841592127, 18129.728054079165, 20425.28511502098, 19967.60064798703, 20514.0, 20832.68750968733, 20904.37286881396, 21040.57918841626, 972.8832540095199, 974.3228456222928, 977.4135518688801, 977.8288799460101, 978.6183388478463, 965.4979410706428, 1003.9749006274865, 1006.099540910888, 1007.1791489935679, 1008.0625018732576, 1049.732318258843, 1057.1912486947454, 1058.0, 1059.4914441068292, 1060.7666313411037, 1043.598214687347, 1045.2108657963265, 1045.2735348932495, 1045.9947700261525, 1047.748540350318, 770.1682183242085, 770.7841804294807, 771.5833449937028, 773.6247919758913, 776.0454640791801, 18533.721994170097, 18708.0, 18861.905690471598, 18914.24343026291, 19422.320218792414, 20792.48018799527, 20982.580348393098, 21401.785982140136, 21460.356189314345, 21494.0, 12314.13801033928, 12338.444769985372, 12367.07246956473, 12446.25322480645, 12486.81269780954, 3647.3799454092605, 3708.313961917027, 3761.4545890845675, 3781.3949768037255, 3783.7540559863796, 121056.0, 122168.72409465627, 122242.0, 123871.3806430971, 124448.0, 16439.342426303054, 16781.24484398205, 16810.41163559294, 16905.0, 16949.661006779796, 30234.84882575573, 31030.844845775628, 31324.0, 31391.37217255642, 31419.214519637193, 8649.870251946226, 8656.567171641393, 8803.339749518811, 8864.468131912106, 8866.733997979942, 3856.9807150964066, 3903.6291552302487, 3903.726739128234, 3923.391874259494, 3936.4488971544006, 4801.591864691471, 4901.681390709664, 4908.214685650279, 4936.3829521309835, 4946.505349465025, 916.2212119698337, 917.3624331089828, 934.3506263147048, 937.6015193542853, 939.9436033837854, 680.1667956753037, 701.225146213437, 703.2756261051126, 717.5730440387961, 719.989200161998, 11429.314241145392, 11718.296902185726, 11955.701107472383, 12050.578229761917, 12474.937625311815, 665.9567128136656, 669.0499490723184, 677.695037233247, 677.8644271145691, 692.6571347183177, 5409.323834520685, 5590.273264475592, 5661.433856614388, 5724.1413787931315, 5986.311574168939, 108788.4560577192, 108986.0, 109937.0, 110258.0, 110532.0, 93525.53237233906, 97207.0, 99017.0, 100600.0, 101412.0, 86408.703869442, 86687.56656216679, 87605.561972191, 88871.55564222267, 89915.55042224747, 10791.784164316827, 10946.39794811293, 10973.122150228122, 11052.834207487054, 11171.106311495223, 31703.84148079245, 39626.60373396229, 41666.0, 42373.36439953341, 42641.57358426376, 70251.64874175597, 70744.0, 73100.0, 74680.0, 75986.0, 18031.459056228334, 18839.529011774266, 19124.043797809776, 19152.80847191566, 19279.22883084717, 20613.793862061186, 20793.89603051975, 21033.684494732897, 21211.7878821216, 21633.13467461284, 18919.337823176123, 19407.2237110514, 19490.90254548718, 19522.121504532613, 19601.411957641292, 17560.56098597545, 17791.911040445233, 17940.282388704305, 18639.254429822657, 19467.51331216731, 18363.449096527125, 18462.261509540007, 18686.15912283923, 18937.621247575247, 19137.234510619975, 12573.308468034345, 12575.056870734548, 12634.178778379375, 12732.554360597334, 12934.870651293366, 13626.182429054288, 13667.384967676677, 13729.588112356645, 13810.309484525935, 14385.496507622183], "value": 9009.646469730485, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1477.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 101.0, 109.0, 109.0, 108.0, 108.0, 98.0, 109.0, 109.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 114.0, 139.0, 178.0, 117.0, 149.0, 147.0, 116.0, 168.0, 116.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 162.0, 161.0, 162.0, 166.0, 174.0, 165.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 161.0, 75.0, 74.0, 75.0, 93.0, 99.0, 75.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 130.0, 79.0, 79.0, 78.0, 135.0, 79.0, 79.0, 129.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 119.0, 113.0, 113.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 146.0, 148.0, 148.0, 148.0, 148.0, 150.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 101.0, 98.0, 93.0, 94.0, 93.0, 93.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 51.0, 51.0, 51.0, 52.0, 52.0, 52.0, 56.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 38.0, 37.0, 37.0, 37.0, 38.0, 39.0, 38.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 73.0, 74.0, 74.0, 73.0, 78.0, 73.0, 76.0, 76.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 133.0, 117.0, 124.0, 121.0, 120.0, 114.0, 116.0, 123.0, 162.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 173.0, 168.0, 179.0, 171.0, 178.0, 171.0, 172.0, 173.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 66.0, 64.0, 65.0, 66.0, 72.0, 64.0, 65.0, 63.0], "value": 65.3, "unit": "score"}]}]} 17:36:35 INFO - Return code: 0 17:36:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:36:35 INFO - # TBPL SUCCESS # 17:36:35 INFO - Running post-action listener: _package_coverage_data 17:36:35 INFO - Running post-action listener: _resource_record_post_action 17:36:35 INFO - [mozharness: 2017-09-02 00:36:35.850138Z] Finished run-tests step (success) 17:36:35 INFO - Running post-run listener: _resource_record_post_run 17:36:35 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 394178560; Read time: 144; Write time: 225552 17:36:35 INFO - TinderboxPrint: CPU usage
13.1% 17:36:35 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 144 17:36:35 INFO - TinderboxPrint: I/O write bytes / time
394,178,560 / 225,552 17:36:35 INFO - TinderboxPrint: CPU idle
8,236.9 (86.9%) 17:36:35 INFO - TinderboxPrint: CPU user
1,193.3 (12.6%) 17:36:35 INFO - TinderboxPrint: Swap in / out
0 / 0 17:36:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109359104; Read time: 0; Write time: 64968 17:36:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:36:35 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284819456; Read time: 144; Write time: 160584 17:36:36 INFO - Running post-run listener: _upload_blobber_files 17:36:36 INFO - Blob upload gear active. 17:36:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:36:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:36:36 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'] 17:36:36 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 17:36:36 INFO - (blobuploader) - INFO - Open directory for files ... 17:36:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:36:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:40 INFO - (blobuploader) - INFO - Done attempting. 17:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:41 INFO - (blobuploader) - INFO - Done attempting. 17:36:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:36:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:36:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:42 INFO - (blobuploader) - INFO - Done attempting. 17:36:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:36:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:36:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:43 INFO - (blobuploader) - INFO - Done attempting. 17:36:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:43 INFO - Return code: 0 17:36:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:36:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:43 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7328cd15c729bac836a51caa046243a3262ce078a17626000ad969f4dffabdba3ded7187e46221a052670b7cb50af6dd038db9389503f7957147427bbf89581f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/388a95306f93a73bf5ad73e69abcc51ba105a6322e58be5cb4506948343c87eed15a3fb3a14644abce64acfe4568feee65ef95e17582b7e74abb7246f0ef77b0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aff9c05623ad1b97974de4e62d29332a46f629ae21beba1ff0d79545d6a2082a8c5d1afaddf82f9234d6982c1d9b2d801231cdeecb0b4ee5d811d3d18e2801c5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc92e869e86eca2568afe2bc8f73d94b77204e642cc1c18c7f2cfa852fbd820cde6c02852792e0bfd58bcbcbdac32783c19c3750318b1115bb7e77b1b3855992"} 17:36:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:36:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:36:43 INFO - Contents: 17:36:43 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7328cd15c729bac836a51caa046243a3262ce078a17626000ad969f4dffabdba3ded7187e46221a052670b7cb50af6dd038db9389503f7957147427bbf89581f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/388a95306f93a73bf5ad73e69abcc51ba105a6322e58be5cb4506948343c87eed15a3fb3a14644abce64acfe4568feee65ef95e17582b7e74abb7246f0ef77b0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aff9c05623ad1b97974de4e62d29332a46f629ae21beba1ff0d79545d6a2082a8c5d1afaddf82f9234d6982c1d9b2d801231cdeecb0b4ee5d811d3d18e2801c5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc92e869e86eca2568afe2bc8f73d94b77204e642cc1c18c7f2cfa852fbd820cde6c02852792e0bfd58bcbcbdac32783c19c3750318b1115bb7e77b1b3855992"} 17:36:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:43 INFO - Copying logs to upload dir... 17:36:43 INFO - mkdir: /builds/slave/test/build/upload/logs 17:36:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.236823 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-01 17:36:43.175957) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 17:36:43.179232) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7328cd15c729bac836a51caa046243a3262ce078a17626000ad969f4dffabdba3ded7187e46221a052670b7cb50af6dd038db9389503f7957147427bbf89581f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/388a95306f93a73bf5ad73e69abcc51ba105a6322e58be5cb4506948343c87eed15a3fb3a14644abce64acfe4568feee65ef95e17582b7e74abb7246f0ef77b0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aff9c05623ad1b97974de4e62d29332a46f629ae21beba1ff0d79545d6a2082a8c5d1afaddf82f9234d6982c1d9b2d801231cdeecb0b4ee5d811d3d18e2801c5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc92e869e86eca2568afe2bc8f73d94b77204e642cc1c18c7f2cfa852fbd820cde6c02852792e0bfd58bcbcbdac32783c19c3750318b1115bb7e77b1b3855992"} build_url:https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/Dw0q0U3MRZ6Rav7W5HAwLw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7328cd15c729bac836a51caa046243a3262ce078a17626000ad969f4dffabdba3ded7187e46221a052670b7cb50af6dd038db9389503f7957147427bbf89581f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/388a95306f93a73bf5ad73e69abcc51ba105a6322e58be5cb4506948343c87eed15a3fb3a14644abce64acfe4568feee65ef95e17582b7e74abb7246f0ef77b0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aff9c05623ad1b97974de4e62d29332a46f629ae21beba1ff0d79545d6a2082a8c5d1afaddf82f9234d6982c1d9b2d801231cdeecb0b4ee5d811d3d18e2801c5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc92e869e86eca2568afe2bc8f73d94b77204e642cc1c18c7f2cfa852fbd820cde6c02852792e0bfd58bcbcbdac32783c19c3750318b1115bb7e77b1b3855992"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 17:36:43.208201) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 17:36:43.208569) ========= 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=31acecf42b6a79ec49471d4a000001bb-1504311347.18344-126477983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 17:36:43.291697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 17:36:43.292161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 17:36:43.292751) ========= ========= Total master_lag: 0.19 =========