builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1504824228.87 results: success (0) revision: 64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:48.869402) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:48.869836) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:48.870122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:48.882635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:48.883028) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 15:43:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2017-09-07 15:43:49 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.187296 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:49.087368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:49.087790) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015762 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:49.139717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:49.140222) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e --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 64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e --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=e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 15:43:49,216 truncating revision to first 12 chars 2017-09-07 15:43:49,216 Setting DEBUG logging. 2017-09-07 15:43:49,216 attempt 1/10 2017-09-07 15:43:49,216 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/64bf417d1bdf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-07 15:43:49,571 unpacking tar archive at: mozilla-central-64bf417d1bdf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622368 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:49.779864) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:49.780261) ========= script_repo_revision: 64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:49.780640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:49.780909) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 15:43:49.794210) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-07 15:43:49.794640) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:43:49 INFO - MultiFileLogger online at 20170907 15:43:49 in /builds/slave/test 15:43: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 15:43:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:43:50 INFO - {'append_to_log': False, 15:43:50 INFO - 'base_work_dir': '/builds/slave/test', 15:43:50 INFO - 'blob_upload_branch': 'Firefox', 15:43:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:43:50 INFO - 'branch': 'Firefox', 15:43:50 INFO - 'buildbot_json_path': 'buildprops.json', 15:43:50 INFO - 'code_coverage': False, 15:43:50 INFO - 'config_files': ('talos/linux_config.py',), 15:43:50 INFO - 'default_actions': ('clobber', 15:43:50 INFO - 'read-buildbot-config', 15:43:50 INFO - 'download-and-extract', 15:43:50 INFO - 'populate-webroot', 15:43:50 INFO - 'create-virtualenv', 15:43:50 INFO - 'install', 15:43:50 INFO - 'setup-mitmproxy', 15:43:50 INFO - 'run-tests'), 15:43:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:43:50 INFO - 'disable_ccov_upload': False, 15:43:50 INFO - 'disable_stylo': False, 15:43:50 INFO - 'download_minidump_stackwalk': True, 15:43:50 INFO - 'download_symbols': 'ondemand', 15:43:50 INFO - 'enable_stylo': False, 15:43:50 INFO - 'enable_webrender': False, 15:43:50 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:43:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:43:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:43:50 INFO - 'gecko_profile': False, 15:43:50 INFO - 'gecko_profile_interval': 0, 15:43:50 INFO - 'installer_path': 'installer.exe', 15:43:50 INFO - 'log_level': 'info', 15:43:50 INFO - 'log_name': 'talos', 15:43:50 INFO - 'log_to_console': True, 15:43:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:43:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:43:50 INFO - 'opt_config_files': (), 15:43:50 INFO - 'pip_index': False, 15:43:50 INFO - 'suite': 'dromaeojs-e10s', 15:43:50 INFO - 'system_bits': '32', 15:43:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:43:50 INFO - 'title': 'talos-linux64-ix-067', 15:43:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:43:50 INFO - 'use_talos_json': True, 15:43:50 INFO - 'verify': 'False', 15:43:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:43:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:43:50 INFO - 'work_dir': 'build'} 15:43:50 INFO - [mozharness: 2017-09-07 22:43:50.014321Z] Running clobber step. 15:43:50 INFO - Running pre-action listener: _resource_record_pre_action 15:43:50 INFO - Running main action method: clobber 15:43:50 INFO - rmtree: /builds/slave/test/build 15:43:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:43:51 INFO - Running post-action listener: _resource_record_post_action 15:43:51 INFO - [mozharness: 2017-09-07 22:43:51.186513Z] Finished clobber step (success) 15:43:51 INFO - [mozharness: 2017-09-07 22:43:51.186611Z] Running read-buildbot-config step. 15:43:51 INFO - Running pre-action listener: _resource_record_pre_action 15:43:51 INFO - Running main action method: read_buildbot_config 15:43:51 INFO - Using buildbot properties: 15:43:51 INFO - { 15:43:51 INFO - "project": "", 15:43:51 INFO - "product": "firefox", 15:43:51 INFO - "who": "archaeopteryx@coole-files.de", 15:43:51 INFO - "installer_path": "public/build/target.tar.bz2", 15:43:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 15:43:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:43:51 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 15:43:51 INFO - "stage_platform": "linux64-stylosequential", 15:43:51 INFO - "basedir": "/builds/slave/test", 15:43:51 INFO - "buildnumber": 235, 15:43:51 INFO - "platform": "ubuntu64_hw_styloseq", 15:43:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:43:51 INFO - "slavebuilddir": "test", 15:43:51 INFO - "taskId": "Ekejas6mS7OBFEe-BLXg3Q", 15:43:51 INFO - "branch": "mozilla-central", 15:43:51 INFO - "script_repo_revision": "production", 15:43:51 INFO - "revision": "64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e", 15:43:51 INFO - "slavename": "talos-linux64-ix-067", 15:43:51 INFO - "repo_path": "mozilla-central" 15:43:51 INFO - } 15:43:51 INFO - Finding installer, test and symbols from parent task. 15:43:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ekejas6mS7OBFEe-BLXg3Q'}, attempt #1 15:43:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ekejas6mS7OBFEe-BLXg3Q'}, attempt #1 15:43:52 INFO - Task dependencies: HU_acp97TAesHcVo7pnBow 15:43:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow'}, attempt #1 15:43:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2 15:43:52 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.test_packages.json 15:43:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.crashreporter-symbols.zip 15:43:52 INFO - Running post-action listener: _resource_record_post_action 15:43:52 INFO - [mozharness: 2017-09-07 22:43:52.553445Z] Finished read-buildbot-config step (success) 15:43:52 INFO - [mozharness: 2017-09-07 22:43:52.553665Z] Running download-and-extract step. 15:43:52 INFO - Running pre-action listener: _resource_record_pre_action 15:43:52 INFO - Running main action method: download_and_extract 15:43:52 INFO - mkdir: /builds/slave/test/build/tests 15:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:52 INFO - trying https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.test_packages.json 15:43:52 INFO - Downloading https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:43:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:43:53 INFO - Downloaded 989 bytes. 15:43:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:43:53 INFO - Using the following test package requirements: 15:43:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:43:53 INFO - u'common': [u'target.common.tests.zip'], 15:43:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:43:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:43:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:43:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:43:53 INFO - u'mozbase': [u'target.common.tests.zip'], 15:43:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:43:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:43:53 INFO - u'web-platform': [u'target.common.tests.zip', 15:43:53 INFO - u'target.web-platform.tests.tar.gz'], 15:43:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:43:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:43:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.common.tests.zip 15:43:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:43:53 INFO - Fetch https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.common.tests.zip into memory 15:43:54 INFO - Content-Length response header: 55021152 15:43:54 INFO - Bytes received: 55021152 15:44:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:44:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.common.tests.zip 15:44:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:44:05 INFO - Fetch https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.common.tests.zip into memory 15:44:06 INFO - Content-Length response header: 55021152 15:44:06 INFO - Bytes received: 55021152 15:44:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.talos.tests.zip 15:44:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:44:18 INFO - Fetch https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.talos.tests.zip into memory 15:44:19 INFO - Content-Length response header: 14496665 15:44:19 INFO - Bytes received: 14496665 15:44:19 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')]} 15:44:19 INFO - trying https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2 15:44:19 INFO - Downloading https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:44:20 INFO - Downloaded 62707151 bytes. 15:44:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2 15:44:20 INFO - mkdir: /builds/slave/test/properties 15:44:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:44:20 INFO - Writing to file /builds/slave/test/properties/build_url 15:44:20 INFO - Contents: 15:44:20 INFO - build_url:https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2 15:44:20 INFO - Running post-action listener: _resource_record_post_action 15:44:20 INFO - Running post-action listener: find_tests_for_verification 15:44:20 INFO - Running post-action listener: set_extra_try_arguments 15:44:20 INFO - [mozharness: 2017-09-07 22:44:20.900607Z] Finished download-and-extract step (success) 15:44:20 INFO - [mozharness: 2017-09-07 22:44:20.900703Z] Running populate-webroot step. 15:44:20 INFO - Running pre-action listener: _resource_record_pre_action 15:44:20 INFO - Running main action method: populate_webroot 15:44:20 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:44:20 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:44:20 INFO - 'tests': ['tresize', 15:44:20 INFO - 'tcanvasmark']}, 15:44:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:44:20 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:44:20 INFO - 'tests': ['dromaeo_css', 15:44:20 INFO - 'kraken']}, 15:44:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:44:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:20 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:44:20 INFO - 'talos_options': ['--disable-stylo'], 15:44:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:44:20 INFO - 'tests': ['damp', 'tps']}, 15:44:20 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:44:20 INFO - 'talos_options': ['--disable-stylo'], 15:44:20 INFO - 'tests': ['damp', 'tps']}, 15:44:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:44:20 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:44:20 INFO - 'tests': ['dromaeo_dom']}, 15:44:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:44:20 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:44:20 INFO - 'tests': ['basic_compositor_video', 15:44:20 INFO - 'glvideo']}, 15:44:20 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:44:20 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:44:20 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:44:20 INFO - 'talos_options': ['--disable-stylo'], 15:44:20 INFO - 'tests': ['ts_paint_webext', 15:44:20 INFO - 'tp5o_webext']}, 15:44:20 INFO - 'other-e10s': {'tests': ['a11yr', 15:44:20 INFO - 'ts_paint', 15:44:20 INFO - 'tpaint', 15:44:20 INFO - 'sessionrestore', 15:44:20 INFO - 'sessionrestore_many_windows', 15:44:20 INFO - 'sessionrestore_no_auto_restore', 15:44:20 INFO - 'tabpaint']}, 15:44:20 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:44:20 INFO - 'tests': ['a11yr', 15:44:20 INFO - 'ts_paint', 15:44:20 INFO - 'tpaint', 15:44:20 INFO - 'sessionrestore', 15:44:20 INFO - 'sessionrestore_many_windows', 15:44:20 INFO - 'sessionrestore_no_auto_restore', 15:44:20 INFO - 'tabpaint']}, 15:44:20 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:44:20 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:44:20 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:44:20 INFO - 'tests': ['bloom_basic_singleton']}, 15:44:20 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:44:20 INFO - 'tests': ['bloom_basic']}, 15:44:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:44:20 INFO - 'tsvgr_opacity', 15:44:20 INFO - 'tart', 15:44:20 INFO - 'tscrollx', 15:44:20 INFO - 'tsvg_static']}, 15:44:20 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:44:20 INFO - 'tests': ['tsvgx', 15:44:20 INFO - 'tsvgr_opacity', 15:44:20 INFO - 'tart', 15:44:20 INFO - 'tscrollx', 15:44:20 INFO - 'tsvg_static']}, 15:44:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:44:20 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:44:20 INFO - 'talos_options': ['--disable-stylo'], 15:44:20 INFO - 'tests': ['tp5o']}, 15:44:20 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:44:20 INFO - 'talos_options': ['--mitmproxy', 15:44:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:44:20 INFO - '--firstNonBlankPaint'], 15:44:20 INFO - 'tests': ['tp6_google', 15:44:20 INFO - 'tp6_youtube', 15:44:20 INFO - 'tp6_amazon', 15:44:20 INFO - 'tp6_facebook']}, 15:44:20 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:44:20 INFO - 'talos_options': ['--disable-stylo', 15:44:20 INFO - '--mitmproxy', 15:44:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:44:20 INFO - '--firstNonBlankPaint'], 15:44:20 INFO - 'tests': ['tp6_google', 15:44:20 INFO - 'tp6_youtube', 15:44:20 INFO - 'tp6_amazon', 15:44:20 INFO - 'tp6_facebook']}, 15:44:20 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:44:20 INFO - 'talos_options': ['--stylo-threads=1', 15:44:20 INFO - '--mitmproxy', 15:44:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:44:20 INFO - '--firstNonBlankPaint'], 15:44:20 INFO - 'tests': ['tp6_google', 15:44:20 INFO - 'tp6_youtube', 15:44:20 INFO - 'tp6_amazon', 15:44:20 INFO - 'tp6_facebook']}, 15:44:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:44:20 INFO - 'talos_options': ['--xperf_path', 15:44:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:20 INFO - 'tests': ['tp5n']}, 15:44:20 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:44:20 INFO - 'talos_options': ['--disable-stylo', 15:44:20 INFO - '--xperf_path', 15:44:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:20 INFO - 'tests': ['tp5n']}}} 15:44:20 INFO - Running post-action listener: _resource_record_post_action 15:44:20 INFO - [mozharness: 2017-09-07 22:44:20.915946Z] Finished populate-webroot step (success) 15:44:20 INFO - [mozharness: 2017-09-07 22:44:20.916036Z] Running create-virtualenv step. 15:44:20 INFO - Running pre-action listener: _resource_record_pre_action 15:44:20 INFO - Running main action method: create_virtualenv 15:44:20 INFO - Creating virtualenv /builds/slave/test/build/venv 15:44:20 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:44:20 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:44:20 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:44:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:44:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:44:21 INFO - Installing distribute.............................................................................................................................................................................................done. 15:44:21 INFO - Installing pip...............done. 15:44:21 INFO - Return code: 0 15:44:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:44:21 INFO - Reading from file tmpfile_stdout 15:44:21 INFO - Output received: 15:44:21 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:44:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:44:21 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')]} 15:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:21 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')]} 15:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:21 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 0x19fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d66a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a090>, '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 0x1d6ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d64f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', '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 15:44:21 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 15:44:21 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 15:44:21 INFO - Using env: {'DISPLAY': ':0', 15:44:21 INFO - 'HOME': '/home/cltbld', 15:44:21 INFO - 'LANG': 'en_US.UTF-8', 15:44:21 INFO - 'LANGUAGE': 'en_US:en', 15:44:21 INFO - 'LOGNAME': 'cltbld', 15:44:21 INFO - 'MAIL': '/var/mail/cltbld', 15:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:21 INFO - 'MOZ_NO_REMOTE': '1', 15:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:21 INFO - 'NO_EM_RESTART': '1', 15:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:21 INFO - 'PWD': '/builds/slave/test', 15:44:21 INFO - 'SHELL': '/bin/bash', 15:44:21 INFO - 'SHLVL': '1', 15:44:21 INFO - 'TERM': 'linux', 15:44:21 INFO - 'TMOUT': '86400', 15:44:21 INFO - 'USER': 'cltbld', 15:44:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 15:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:21 INFO - '_': '/tools/buildbot/bin/python'} 15:44:23 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:44:23 INFO - Downloading/unpacking pip>=1.5 15:44:23 INFO - Running setup.py egg_info for package pip 15:44:23 INFO - warning: no files found matching 'pip/cacert.pem' 15:44:23 INFO - warning: no files found matching '*.html' under directory 'docs' 15:44:23 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:44:23 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:44:23 INFO - Installing collected packages: pip 15:44:23 INFO - Found existing installation: pip 1.1 15:44:23 INFO - Uninstalling pip: 15:44:23 INFO - Successfully uninstalled pip 15:44:23 INFO - Running setup.py install for pip 15:44:23 INFO - warning: no files found matching 'pip/cacert.pem' 15:44:23 INFO - warning: no files found matching '*.html' under directory 'docs' 15:44:23 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:44:23 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:44:23 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:44:23 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:44:23 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:44:23 INFO - Successfully installed pip 15:44:23 INFO - Cleaning up... 15:44:23 INFO - Return code: 0 15:44:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:44:23 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')]} 15:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:23 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')]} 15:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:23 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 0x19fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d66a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a090>, '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 0x1d6ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d64f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', '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 15:44:23 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 15:44:23 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 15:44:23 INFO - Using env: {'DISPLAY': ':0', 15:44:23 INFO - 'HOME': '/home/cltbld', 15:44:23 INFO - 'LANG': 'en_US.UTF-8', 15:44:23 INFO - 'LANGUAGE': 'en_US:en', 15:44:23 INFO - 'LOGNAME': 'cltbld', 15:44:23 INFO - 'MAIL': '/var/mail/cltbld', 15:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:23 INFO - 'MOZ_NO_REMOTE': '1', 15:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:23 INFO - 'NO_EM_RESTART': '1', 15:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:23 INFO - 'PWD': '/builds/slave/test', 15:44:23 INFO - 'SHELL': '/bin/bash', 15:44:23 INFO - 'SHLVL': '1', 15:44:23 INFO - 'TERM': 'linux', 15:44:23 INFO - 'TMOUT': '86400', 15:44:23 INFO - 'USER': 'cltbld', 15:44:23 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 15:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:23 INFO - '_': '/tools/buildbot/bin/python'} 15:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:23 INFO - Downloading/unpacking psutil>=3.1.1 15:44:23 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 15:44:23 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 15:44:23 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 15:44:23 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 15:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:44:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:24 INFO - Installing collected packages: psutil 15:44:24 INFO - Running setup.py install for psutil 15:44:24 INFO - building 'psutil._psutil_linux' extension 15:44:24 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 15:44:24 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 15:44:24 INFO - building 'psutil._psutil_posix' extension 15:44:24 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 15:44:24 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 15:44:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:25 INFO - Successfully installed psutil 15:44:25 INFO - Cleaning up... 15:44:25 INFO - Return code: 0 15:44:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:25 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 0x19fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d66a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a090>, '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 0x1d6ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d64f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', '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 15:44:25 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 15:44:25 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 15:44:25 INFO - Using env: {'DISPLAY': ':0', 15:44:25 INFO - 'HOME': '/home/cltbld', 15:44:25 INFO - 'LANG': 'en_US.UTF-8', 15:44:25 INFO - 'LANGUAGE': 'en_US:en', 15:44:25 INFO - 'LOGNAME': 'cltbld', 15:44:25 INFO - 'MAIL': '/var/mail/cltbld', 15:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:25 INFO - 'MOZ_NO_REMOTE': '1', 15:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:25 INFO - 'NO_EM_RESTART': '1', 15:44:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:25 INFO - 'PWD': '/builds/slave/test', 15:44:25 INFO - 'SHELL': '/bin/bash', 15:44:25 INFO - 'SHLVL': '1', 15:44:25 INFO - 'TERM': 'linux', 15:44:25 INFO - 'TMOUT': '86400', 15:44:25 INFO - 'USER': 'cltbld', 15:44:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 15:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:25 INFO - '_': '/tools/buildbot/bin/python'} 15:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:44:25 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 15:44:25 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 15:44:25 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 15:44:25 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 15:44:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:44:26 INFO - Installing collected packages: mozsystemmonitor 15:44:26 INFO - Running setup.py install for mozsystemmonitor 15:44:26 INFO - Successfully installed mozsystemmonitor 15:44:26 INFO - Cleaning up... 15:44:26 INFO - Return code: 0 15:44:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:44:26 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')]} 15:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:26 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')]} 15:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:26 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 0x19fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d66a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a090>, '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 0x1d6ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d64f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', '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 15:44:26 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 15:44:26 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 15:44:26 INFO - Using env: {'DISPLAY': ':0', 15:44:26 INFO - 'HOME': '/home/cltbld', 15:44:26 INFO - 'LANG': 'en_US.UTF-8', 15:44:26 INFO - 'LANGUAGE': 'en_US:en', 15:44:26 INFO - 'LOGNAME': 'cltbld', 15:44:26 INFO - 'MAIL': '/var/mail/cltbld', 15:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:26 INFO - 'MOZ_NO_REMOTE': '1', 15:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:26 INFO - 'NO_EM_RESTART': '1', 15:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:26 INFO - 'PWD': '/builds/slave/test', 15:44:26 INFO - 'SHELL': '/bin/bash', 15:44:26 INFO - 'SHLVL': '1', 15:44:26 INFO - 'TERM': 'linux', 15:44:26 INFO - 'TMOUT': '86400', 15:44:26 INFO - 'USER': 'cltbld', 15:44:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 15:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:26 INFO - '_': '/tools/buildbot/bin/python'} 15:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:26 INFO - Downloading/unpacking jsonschema==2.5.1 15:44:26 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 15:44:26 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 15:44:26 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 15:44:26 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 15:44:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:44:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:44:27 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 15:44:27 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 15:44:27 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 15:44:27 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 15:44:28 INFO - Downloading functools32-3.2.3-2.tar.gz 15:44:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:44:28 INFO - warning: no files found matching '*.txt' 15:44:28 INFO - no previously-included directories found matching 'build' 15:44:28 INFO - no previously-included directories found matching 'dist' 15:44:28 INFO - no previously-included directories found matching '.git*' 15:44:28 INFO - Installing collected packages: jsonschema, functools32 15:44:28 INFO - Running setup.py install for functools32 15:44:28 INFO - warning: no files found matching '*.txt' 15:44:28 INFO - no previously-included directories found matching 'build' 15:44:28 INFO - no previously-included directories found matching 'dist' 15:44:28 INFO - no previously-included directories found matching '.git*' 15:44:28 INFO - Successfully installed jsonschema functools32 15:44:28 INFO - Cleaning up... 15:44:28 INFO - Return code: 0 15:44:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44: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')]} 15:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44: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', '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 0x19fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d66a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a090>, '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 0x1d6ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d64f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', '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 15:44: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:44: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 functools32==3.2.3-2 15:44:28 INFO - Using env: {'DISPLAY': ':0', 15:44:28 INFO - 'HOME': '/home/cltbld', 15:44:28 INFO - 'LANG': 'en_US.UTF-8', 15:44:28 INFO - 'LANGUAGE': 'en_US:en', 15:44:28 INFO - 'LOGNAME': 'cltbld', 15:44:28 INFO - 'MAIL': '/var/mail/cltbld', 15:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:28 INFO - 'MOZ_NO_REMOTE': '1', 15:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:28 INFO - 'NO_EM_RESTART': '1', 15:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:28 INFO - 'PWD': '/builds/slave/test', 15:44:28 INFO - 'SHELL': '/bin/bash', 15:44:28 INFO - 'SHLVL': '1', 15:44:28 INFO - 'TERM': 'linux', 15:44:28 INFO - 'TMOUT': '86400', 15:44:28 INFO - 'USER': 'cltbld', 15:44:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 15:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:28 INFO - '_': '/tools/buildbot/bin/python'} 15:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:44:28 INFO - Cleaning up... 15:44:28 INFO - Return code: 0 15:44:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44: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')]} 15:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44: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', '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 0x19fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d66a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a090>, '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 0x1d6ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d64f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', '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 15:44: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:44: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 blobuploader==1.2.4 15:44:28 INFO - Using env: {'DISPLAY': ':0', 15:44:28 INFO - 'HOME': '/home/cltbld', 15:44:28 INFO - 'LANG': 'en_US.UTF-8', 15:44:28 INFO - 'LANGUAGE': 'en_US:en', 15:44:28 INFO - 'LOGNAME': 'cltbld', 15:44:28 INFO - 'MAIL': '/var/mail/cltbld', 15:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:28 INFO - 'MOZ_NO_REMOTE': '1', 15:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:28 INFO - 'NO_EM_RESTART': '1', 15:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:28 INFO - 'PWD': '/builds/slave/test', 15:44:28 INFO - 'SHELL': '/bin/bash', 15:44:28 INFO - 'SHLVL': '1', 15:44:28 INFO - 'TERM': 'linux', 15:44:28 INFO - 'TMOUT': '86400', 15:44:28 INFO - 'USER': 'cltbld', 15:44:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 15:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:28 INFO - '_': '/tools/buildbot/bin/python'} 15:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:28 INFO - Downloading/unpacking blobuploader==1.2.4 15:44:28 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 15:44:28 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 15:44:28 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 15:44:28 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 15:44:29 INFO - Downloading blobuploader-1.2.4.tar.gz 15:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:44:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:44: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 15:44: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 15:44: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 15:44: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 15:44:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:44:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:30 INFO - Downloading docopt-0.6.1.tar.gz 15:44:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:44:30 INFO - Installing collected packages: blobuploader, requests, docopt 15:44:30 INFO - Running setup.py install for blobuploader 15:44:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:44:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:44:30 INFO - Running setup.py install for requests 15:44:30 INFO - Running setup.py install for docopt 15:44:30 INFO - Successfully installed blobuploader requests docopt 15:44:30 INFO - Cleaning up... 15:44:30 INFO - Return code: 0 15:44:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:30 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 0x19fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d66a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a090>, '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 0x1d6ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d64f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', '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 15:44:30 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 15:44:30 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 15:44:30 INFO - Using env: {'DISPLAY': ':0', 15:44:30 INFO - 'HOME': '/home/cltbld', 15:44:30 INFO - 'LANG': 'en_US.UTF-8', 15:44:30 INFO - 'LANGUAGE': 'en_US:en', 15:44:30 INFO - 'LOGNAME': 'cltbld', 15:44:30 INFO - 'MAIL': '/var/mail/cltbld', 15:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:30 INFO - 'MOZ_NO_REMOTE': '1', 15:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:30 INFO - 'NO_EM_RESTART': '1', 15:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:30 INFO - 'PWD': '/builds/slave/test', 15:44:30 INFO - 'SHELL': '/bin/bash', 15:44:30 INFO - 'SHLVL': '1', 15:44:30 INFO - 'TERM': 'linux', 15:44:30 INFO - 'TMOUT': '86400', 15:44:30 INFO - 'USER': 'cltbld', 15:44:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 15:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:30 INFO - '_': '/tools/buildbot/bin/python'} 15:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:31 INFO - Running setup.py (path:/tmp/pip-N4m4Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:31 INFO - Running setup.py (path:/tmp/pip-b9ZTw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:31 INFO - Running setup.py (path:/tmp/pip-43PYRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:31 INFO - Running setup.py (path:/tmp/pip-MGjiaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:31 INFO - Running setup.py (path:/tmp/pip-w9okUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:31 INFO - Running setup.py (path:/tmp/pip-0LzM6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:31 INFO - Running setup.py (path:/tmp/pip-1PFIni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:31 INFO - Running setup.py (path:/tmp/pip-1tMqt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:31 INFO - Running setup.py (path:/tmp/pip-GQDEa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:31 INFO - Running setup.py (path:/tmp/pip-NTJzC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:31 INFO - Running setup.py (path:/tmp/pip-Ml8PfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:31 INFO - Running setup.py (path:/tmp/pip-TJJQg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:32 INFO - Running setup.py (path:/tmp/pip-RI42tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:32 INFO - Running setup.py (path:/tmp/pip-w80QS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:32 INFO - Running setup.py (path:/tmp/pip-Jjc74u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:32 INFO - Running setup.py (path:/tmp/pip-iCpPFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:32 INFO - Running setup.py (path:/tmp/pip-S_5TXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:44:32 INFO - Running setup.py install for manifestparser 15:44:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:44:32 INFO - Running setup.py install for mozcrash 15:44:32 INFO - Running setup.py install for mozdebug 15:44:32 INFO - Running setup.py install for mozdevice 15:44:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:44:32 INFO - Running setup.py install for mozfile 15:44:32 INFO - Running setup.py install for mozhttpd 15:44:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:44:32 INFO - Running setup.py install for mozinfo 15:44:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:44:33 INFO - Running setup.py install for mozInstall 15:44:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:44:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:44:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:44:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:44:33 INFO - Running setup.py install for mozleak 15:44:33 INFO - Running setup.py install for mozlog 15:44:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:44:33 INFO - Running setup.py install for moznetwork 15:44:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:44:33 INFO - Running setup.py install for mozprocess 15:44:33 INFO - Running setup.py install for mozprofile 15:44:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:44:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:44:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:44:33 INFO - Running setup.py install for mozrunner 15:44:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:44:33 INFO - Running setup.py install for mozscreenshot 15:44:33 INFO - Running setup.py install for moztest 15:44:34 INFO - Running setup.py install for mozversion 15:44:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:44:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:44:34 INFO - Cleaning up... 15:44:34 INFO - Return code: 0 15:44:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44: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')]} 15:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:34 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 0x19fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d66a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a090>, '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 0x1d6ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d64f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', '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 15:44:34 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 15:44:34 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 15:44:34 INFO - Using env: {'DISPLAY': ':0', 15:44:34 INFO - 'HOME': '/home/cltbld', 15:44:34 INFO - 'LANG': 'en_US.UTF-8', 15:44:34 INFO - 'LANGUAGE': 'en_US:en', 15:44:34 INFO - 'LOGNAME': 'cltbld', 15:44:34 INFO - 'MAIL': '/var/mail/cltbld', 15:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:34 INFO - 'MOZ_NO_REMOTE': '1', 15:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:34 INFO - 'NO_EM_RESTART': '1', 15:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:34 INFO - 'PWD': '/builds/slave/test', 15:44:34 INFO - 'SHELL': '/bin/bash', 15:44:34 INFO - 'SHLVL': '1', 15:44:34 INFO - 'TERM': 'linux', 15:44:34 INFO - 'TMOUT': '86400', 15:44:34 INFO - 'USER': 'cltbld', 15:44:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 15:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:34 INFO - '_': '/tools/buildbot/bin/python'} 15:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:34 INFO - Running setup.py (path:/tmp/pip-xO1WCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:34 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)) 15:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:34 INFO - Running setup.py (path:/tmp/pip-7JytBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:34 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)) 15:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:34 INFO - Running setup.py (path:/tmp/pip-SD7cAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:34 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)) 15:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:34 INFO - Running setup.py (path:/tmp/pip-_ynwzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:34 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)) 15:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:34 INFO - Running setup.py (path:/tmp/pip-g660Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:34 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)) 15:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:34 INFO - Running setup.py (path:/tmp/pip-qAcoIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:34 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)) 15:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:34 INFO - Running setup.py (path:/tmp/pip-nE6b19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:34 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)) 15:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:34 INFO - Running setup.py (path:/tmp/pip-JzWB8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:34 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)) 15:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:34 INFO - Running setup.py (path:/tmp/pip-EDWC35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:35 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)) 15:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:35 INFO - Running setup.py (path:/tmp/pip-T5n1CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:35 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)) 15:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:35 INFO - Running setup.py (path:/tmp/pip-e8hqFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:35 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)) 15:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:35 INFO - Running setup.py (path:/tmp/pip-7PzlTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:35 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)) 15:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:35 INFO - Running setup.py (path:/tmp/pip-BjxIx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:35 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)) 15:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:35 INFO - Running setup.py (path:/tmp/pip-Kl9p6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:35 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)) 15:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:35 INFO - Running setup.py (path:/tmp/pip-WagslB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:35 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)) 15:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:35 INFO - Running setup.py (path:/tmp/pip-LkIFMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:35 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)) 15:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:35 INFO - Running setup.py (path:/tmp/pip-ac1L_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 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)) 15:44:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:36 INFO - Downloading blessings-1.6.tar.gz 15:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:44:36 INFO - Installing collected packages: blessings 15:44:36 INFO - Running setup.py install for blessings 15:44:36 INFO - Successfully installed blessings 15:44:36 INFO - Cleaning up... 15:44:36 INFO - Return code: 0 15:44:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:44:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:37 INFO - Reading from file tmpfile_stdout 15:44:37 INFO - Current package versions: 15:44:37 INFO - argparse == 1.2.1 15:44:37 INFO - blessings == 1.6 15:44:37 INFO - blobuploader == 1.2.4 15:44:37 INFO - docopt == 0.6.1 15:44:37 INFO - functools32 == 3.2.3-2 15:44:37 INFO - jsonschema == 2.5.1 15:44:37 INFO - manifestparser == 1.1 15:44:37 INFO - mozInstall == 1.13 15:44:37 INFO - mozcrash == 1.0 15:44:37 INFO - mozdebug == 0.1 15:44:37 INFO - mozdevice == 0.51 15:44:37 INFO - mozfile == 1.2 15:44:37 INFO - mozhttpd == 0.7 15:44:37 INFO - mozinfo == 0.10 15:44:37 INFO - mozleak == 0.1 15:44:37 INFO - mozlog == 3.5 15:44:37 INFO - moznetwork == 0.27 15:44:37 INFO - mozprocess == 0.25 15:44:37 INFO - mozprofile == 0.28 15:44:37 INFO - mozrunner == 6.13 15:44:37 INFO - mozscreenshot == 0.1 15:44:37 INFO - mozsystemmonitor == 0.3 15:44:37 INFO - moztest == 0.8 15:44:37 INFO - mozversion == 1.4 15:44:37 INFO - psutil == 3.1.1 15:44:37 INFO - requests == 1.2.3 15:44:37 INFO - wsgiref == 0.1.2 15:44:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44: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')]} 15:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:37 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 0x19fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d66a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a090>, '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 0x1d6ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d64f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', '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 15:44:37 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 15:44:37 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 15:44:37 INFO - Using env: {'DISPLAY': ':0', 15:44:37 INFO - 'HOME': '/home/cltbld', 15:44:37 INFO - 'LANG': 'en_US.UTF-8', 15:44:37 INFO - 'LANGUAGE': 'en_US:en', 15:44:37 INFO - 'LOGNAME': 'cltbld', 15:44:37 INFO - 'MAIL': '/var/mail/cltbld', 15:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:37 INFO - 'MOZ_NO_REMOTE': '1', 15:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:37 INFO - 'NO_EM_RESTART': '1', 15:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:37 INFO - 'PWD': '/builds/slave/test', 15:44:37 INFO - 'SHELL': '/bin/bash', 15:44:37 INFO - 'SHLVL': '1', 15:44:37 INFO - 'TERM': 'linux', 15:44:37 INFO - 'TMOUT': '86400', 15:44:37 INFO - 'USER': 'cltbld', 15:44:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 15:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:37 INFO - '_': '/tools/buildbot/bin/python'} 15:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:37 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)) 15:44:37 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)) 15:44:37 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)) 15:44:37 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)) 15:44:37 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)) 15:44:37 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)) 15:44:37 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)) 15:44:37 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)) 15:44:37 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)) 15:44:37 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:44:38 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)) 15:44:38 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)) 15:44:38 INFO - Installing collected packages: simplejson 15:44:38 INFO - Running setup.py install for simplejson 15:44:38 INFO - building 'simplejson._speedups' extension 15:44:38 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 15:44:39 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 15:44:39 INFO - Successfully installed simplejson 15:44:39 INFO - Cleaning up... 15:44:39 INFO - Return code: 0 15:44:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:44:39 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')]} 15:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:39 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')]} 15:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:39 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 0x19fa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d66a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a090>, '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 0x1d6ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d64f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', '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 15:44:39 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 15:44:39 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 15:44:39 INFO - Using env: {'DISPLAY': ':0', 15:44:39 INFO - 'HOME': '/home/cltbld', 15:44:39 INFO - 'LANG': 'en_US.UTF-8', 15:44:39 INFO - 'LANGUAGE': 'en_US:en', 15:44:39 INFO - 'LOGNAME': 'cltbld', 15:44:39 INFO - 'MAIL': '/var/mail/cltbld', 15:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:39 INFO - 'MOZ_NO_REMOTE': '1', 15:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:39 INFO - 'NO_EM_RESTART': '1', 15:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:39 INFO - 'PWD': '/builds/slave/test', 15:44:39 INFO - 'SHELL': '/bin/bash', 15:44:39 INFO - 'SHLVL': '1', 15:44:39 INFO - 'TERM': 'linux', 15:44:39 INFO - 'TMOUT': '86400', 15:44:39 INFO - 'USER': 'cltbld', 15:44:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 15:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:39 INFO - '_': '/tools/buildbot/bin/python'} 15:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:44:39 INFO - Cleaning up... 15:44:39 INFO - Return code: 0 15:44:39 INFO - Running post-action listener: _resource_record_post_action 15:44:39 INFO - Running post-action listener: _start_resource_monitoring 15:44:39 INFO - Starting resource monitoring. 15:44:39 INFO - [mozharness: 2017-09-07 22:44:39.941508Z] Finished create-virtualenv step (success) 15:44:39 INFO - [mozharness: 2017-09-07 22:44:39.942033Z] Running install step. 15:44:39 INFO - Running pre-action listener: _resource_record_pre_action 15:44:39 INFO - Running main action method: install 15:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:40 INFO - Reading from file tmpfile_stdout 15:44:40 INFO - Detecting whether we're running mozinstall >=1.0... 15:44:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:44:40 INFO - Reading from file tmpfile_stdout 15:44:40 INFO - Output received: 15:44:40 INFO - Usage: mozinstall [options] installer 15:44:40 INFO - Options: 15:44:40 INFO - -h, --help show this help message and exit 15:44:40 INFO - -d DEST, --destination=DEST 15:44:40 INFO - Directory to install application into. [default: 15:44:40 INFO - "/builds/slave/test"] 15:44:40 INFO - --app=APP Application being installed. [default: firefox] 15:44:40 INFO - mkdir: /builds/slave/test/build/application 15:44:40 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'] 15:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:44:56 INFO - Reading from file tmpfile_stdout 15:44:56 INFO - Output received: 15:44:56 INFO - /builds/slave/test/build/application/firefox/firefox 15:44:56 INFO - Running post-action listener: _resource_record_post_action 15:44:56 INFO - [mozharness: 2017-09-07 22:44:56.818146Z] Finished install step (success) 15:44:56 INFO - [mozharness: 2017-09-07 22:44:56.818396Z] Running setup-mitmproxy step. 15:44:56 INFO - Running pre-action listener: _resource_record_pre_action 15:44:56 INFO - Running main action method: setup_mitmproxy 15:44:56 INFO - Skipping: mitmproxy is not required 15:44:56 INFO - Running post-action listener: _resource_record_post_action 15:44:56 INFO - [mozharness: 2017-09-07 22:44:56.819534Z] Finished setup-mitmproxy step (success) 15:44:56 INFO - [mozharness: 2017-09-07 22:44:56.819752Z] Running run-tests step. 15:44:56 INFO - Running pre-action listener: _resource_record_pre_action 15:44:56 INFO - Running pre-action listener: _set_gcov_prefix 15:44:56 INFO - Running main action method: run_tests 15:44:56 WARNING - Try message not found. 15:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:44:56 INFO - Python 2.7.3 15:44:56 INFO - Return code: 0 15:44:56 INFO - grabbing minidump binary from tooltool 15:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:56 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 0x1d6a090>, '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 0x1d6ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d64f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:44:56 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 15:44:56 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 15:44:56 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 15:44:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:44:56 INFO - Return code: 0 15:44:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:44:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:44:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:44:56 INFO - ENV: RUST_BACKTRACE is now full 15:44:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:44:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:44:56 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/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 15:44:56 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/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 15:44:56 INFO - Using env: {'DISPLAY': ':0', 15:44:56 INFO - 'HOME': '/home/cltbld', 15:44:56 INFO - 'LANG': 'en_US.UTF-8', 15:44:56 INFO - 'LANGUAGE': 'en_US:en', 15:44:56 INFO - 'LOGNAME': 'cltbld', 15:44:56 INFO - 'MAIL': '/var/mail/cltbld', 15:44:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:44:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:56 INFO - 'MOZ_NO_REMOTE': '1', 15:44:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:56 INFO - 'NO_EM_RESTART': '1', 15:44:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:56 INFO - 'PWD': '/builds/slave/test', 15:44:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:44:56 INFO - 'RUST_BACKTRACE': 'full', 15:44:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:44:56 INFO - 'SHELL': '/bin/bash', 15:44:56 INFO - 'SHLVL': '1', 15:44:56 INFO - 'STYLO_FORCE_ENABLED': '1', 15:44:56 INFO - 'STYLO_THREADS': '1', 15:44:56 INFO - 'TERM': 'linux', 15:44:56 INFO - 'TMOUT': '86400', 15:44:56 INFO - 'USER': 'cltbld', 15:44:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 15:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:56 INFO - '_': '/tools/buildbot/bin/python'} 15:44:56 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/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 15:44:57 INFO - mozversion application_buildid: 20170907215054 15:44:57 INFO - mozversion application_changeset: 64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e 15:44:57 INFO - mozversion application_display_name: Nightly 15:44:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:44:57 INFO - mozversion application_name: Firefox 15:44:57 INFO - mozversion application_remotingname: firefox 15:44:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:44:57 INFO - mozversion application_vendor: Mozilla 15:44:57 INFO - mozversion application_version: 57.0a1 15:44:57 INFO - mozversion platform_buildid: 20170907215054 15:44:57 INFO - mozversion platform_changeset: 64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e 15:44:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:44:57 INFO - mozversion platform_version: 57.0a1 15:44:57 INFO - using testdate: 1504824297 15:44:57 INFO - actual date: 1504824297 15:44:57 INFO - starting webserver on 'localhost:51776' 15:44:57 INFO - SUITE-START | Running 2 tests 15:44:57 INFO - TEST-START | dromaeo_css 15:44:57 INFO - Initialising browser for dromaeo_css test... 15:44:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51776/getInfo.html -profile /tmp/tmpKT5E8G/profile 15:44:57 INFO - TEST-INFO | started process 18003 (/builds/slave/test/build/application/firefox/firefox http://localhost:51776/getInfo.html) 15:45:02 INFO - TEST-INFO | 18003: exit 0 15:45:02 INFO - Browser initialized. 15:45:02 INFO - Running cycle 1/1 for dromaeo_css test... 15:45:02 INFO - Using env: {'DISPLAY': ':0', 15:45:02 INFO - 'HOME': '/home/cltbld', 15:45:02 INFO - 'JSGC_DISABLE_POISONING': '1', 15:45:02 INFO - 'LANG': 'en_US.UTF-8', 15:45:02 INFO - 'LANGUAGE': 'en_US:en', 15:45:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:45:02 INFO - 'LOGNAME': 'cltbld', 15:45:02 INFO - 'MAIL': '/var/mail/cltbld', 15:45:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:45:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:45:02 INFO - 'MOZ_CRASHREPORTER': '1', 15:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:45:02 INFO - 'MOZ_NO_REMOTE': '1', 15:45:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:02 INFO - 'NO_EM_RESTART': '1', 15:45:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:02 INFO - 'PWD': '/builds/slave/test', 15:45:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:45:02 INFO - 'RUST_BACKTRACE': 'full', 15:45:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:45:02 INFO - 'SHELL': '/bin/bash', 15:45:02 INFO - 'SHLVL': '1', 15:45:02 INFO - 'STYLO_FORCE_ENABLED': '1', 15:45:02 INFO - 'STYLO_THREADS': '1', 15:45:02 INFO - 'TERM': 'linux', 15:45:02 INFO - 'TMOUT': '86400', 15:45:02 INFO - 'USER': 'cltbld', 15:45:02 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 15:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:02 INFO - '_': '/tools/buildbot/bin/python'} 15:45:02 INFO - TEST-INFO | started process 18182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKT5E8G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:45:03 INFO - PID 18182 | 15:45:03 INFO - PID 18182 | (/builds/slave/test/build/application/firefox/firefox:18233): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:45:03 INFO - PID 18182 | 15:45:13 INFO - PID 18182 | RSS: Main: 172195840 15:45:13 INFO - PID 18182 | 15:48:09 INFO - PID 18182 | Cycle 1(1): loaded http://localhost:51776/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51776/tests/dromaeo/cssquery-ext.html) 15:48:11 INFO - PID 18182 | RSS: Main: 174346240 15:48:11 INFO - PID 18182 | 15:51:12 INFO - PID 18182 | Cycle 1(1): loaded http://localhost:51776/tests/dromaeo/cssquery-ext.html (next: http://localhost:51776/tests/dromaeo/cssquery-jquery.html) 15:51:13 INFO - PID 18182 | RSS: Main: 168955904 15:51:13 INFO - PID 18182 | 15:54:15 INFO - PID 18182 | Cycle 1(1): loaded http://localhost:51776/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51776/tests/dromaeo/cssquery-mootools.html) 15:54:15 INFO - PID 18182 | RSS: Main: 172589056 15:54:15 INFO - PID 18182 | 15:57:17 INFO - PID 18182 | Cycle 1(1): loaded http://localhost:51776/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51776/tests/dromaeo/cssquery-prototype.html) 15:57:18 INFO - PID 18182 | RSS: Main: 169984000 15:57:18 INFO - PID 18182 | 16:00:21 INFO - PID 18182 | Cycle 1(1): loaded http://localhost:51776/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51776/tests/dromaeo/cssquery-yui.html) 16:00:22 INFO - PID 18182 | RSS: Main: 173371392 16:00:22 INFO - PID 18182 | 16:03:23 INFO - PID 18182 | Cycle 1(1): loaded http://localhost:51776/tests/dromaeo/cssquery-yui.html (next: http://localhost:51776/tests/dromaeo/cssquery-dojo.html) 16:03:24 INFO - PID 18182 | RSS: Main: 175587328 16:03:24 INFO - PID 18182 | 16:03:24 INFO - PID 18182 | __start_tp_report 16:03:24 INFO - PID 18182 | _x_x_mozilla_page_load 16:03:24 INFO - PID 18182 | _x_x_mozilla_page_load_details 16:03:24 INFO - PID 18182 | |i|pagename|runs| 16:03:24 INFO - PID 18182 | |0;dojo.html;3064.9846750766246;3088.6602473727885;3099.7055279748415;3104.2549788050874;3114.735247503962;6301.369863013696;6401.61590304582;6431.485481161508;6435.485161187105;6437.2918978912285;6156.168917196177;6292.8741425171465;6293.150424692665;6301.117843501914;6313;5808.448197421239;5862.912056319148;5874.794382196624;5890.617109887844;5897.970510147443;5560.277163968678;5792.913106303409;5863.237779088712;5882.735276912549;5893;5672.716364181795;5687.914681279784;5770.2498675171955;5807.941920580783;5842.386549412336;5767;5779.913301300484;5848.327442344143;5862.443067908542;5890.852728681774;5584.246126772915;5655.660660360391;5676.460736230051;5771.567132465082;5822.039363505017;6312.43188113072;6322.083297921776;6353.936460635381;6361.55469117162;6372.076048972873;6693.263740988487;6744.5616034957575;6829.146356705412;6839.897401538981;6843.589384636938;6752.5948443093575;6809.489288303397;6816.591004539743;6906.861862762717;6907.481938854606;6313.463355614778;6320.5891617044745;6346.6509341986175;6357.33248008957;6359.9364006360265;6835.282295359015;6983.511154219156;7002.7899163025195;7018.7543435980515;7032.859342813115;6614.9669251654395;6647.634380109043;6683;6722.495812814059;6760.560563563451;6501.967490162613;6598.637074960827;6626.56927299724;6774.220964589037;6863.485238607124;6637.668116594151;6660.600363978177;6683.732650693918;6703.061571380011;6733.865322693617;6573.967130164318;6637.203535575762;6751;6751.291114433012;6779.6271205084195;5126.6923984561045;5193.195054766517;5198.662086964335;5201.479852014844;5202.505761952609;4574.862754117382;4616.1229366420275;4641.860744177612;4645.233536466445;4648.558386953234;5826.883462330729;5870.618409803349;5893.322267939242;5899.144624029492;5910.822675319747;6614.338566143347;6699.9665001674675;6714.966425167843;6778.796636100925;6871.725130994704;5746.454086861741;5753.942460575341;5769.711514424346;5773.480386765212;5830.125481177857;5711.257536520226;5769.278840144982;5819.272590926134;5840.912386314209;5843.590948633555;6471.579347342407;6486.156799616114;6577.835554111186;6580.670966451658;6658.533902626867;6510.902336464862;6773.187217533928;6787.864242715217;6878.8624227516175;6887.965560172167;6445.16212892321;6565.507586930904;6573.375529324707;6592.406683398517;6637.933620663925;6653.301403352772;6693.464522838259;6729;6767.89848152288;6809.795706128824;6783.152105986752;6804.9319506804295;6807.183138023469;6871.8317885960505;6873;6300.369963003663;6477.676116194078;6482.967585162044;6484.027395890655;6597.340265973365;6560.507961902781;6577.506686998398;6597.208334999831;6605.669716514251;6646.368594983469;6477.305536473467;6478.611283323015;6480.513961452815;6564.245111812012;6575.539712220098;6439.291677915519;6582.275949645631;6630.701618427279;6633.038209459698;6713.966430168013;6323.36766323364;6378.075179099097;6469.5794773339585;6483.481321494175;6507.739690412331 16:03:24 INFO - PID 18182 | |1;ext.html;839.9286060684841;840.2060053249679;858.6608289725563;860.0926023045688;873.0658195730567;37840;41039.17921641565;41304.17391652165;41440.58559414409;41519;37087.814560927225;37399.626003739955;37442.625573744255;37442.81278593603;37510.43734343987;7025.789226323219;7751.147373788879;7950.801229969239;7954.443188976774;7954.642041108135;7727.459077864552;7831.530108193527;7839.333656639193;7842.529448233125;7844.960775196116;7852.21477852216;7900.486468379566;7908.485948413363;7910.208979102102;7914.366850651934;7833.569153696544;7866.410019248579;7867.567283799389;7873.842523149562;7880.763577092696;7774;7777.105632852238;7781.649825757854;7814.843703125963;7820.257075577811;37192;37424.43863342052;37455.43816842749;37487.81256093702;37506.62493375059;3477.200243943907;3493.6506349365113;3498.405271103893;3508;3512.1746389598425;31237.84381078103;31465.528017079763;31486.055418337488;31543.684563154304;31582.36835263282;5241.42344342122;5243.030039442677;5247.055530004598;5279.60402969775;5294.047071527124;181516;182118;182887;183415.08292458585;183996;40830.18339633191;41729.374059389134;47331.290030649565;47951;48032.759836201294;44422.55577444184;44451.333230001575;51071.489285106676;51653;51841;14987.40050397972;15298.311575979107;15299.235038248044;15318.310676019606;15320.23398830054;12309.876901230873;12339.13626046186;12340.197887137307;12341.259524428384;12344.567940122053;14274.357653905392;14304.85695143056;14311.713765724628;14383.424663013362;14457.49398771059;5769.365369809318;5846.356900740915;5909.349971503131;5974.731137098841;6040.154378387029;1002.14817405205;1010.151472762868;1022.3354819367471;1026.8357062869904;1044.4464433850071;22623.281649616223;22843.657345139836;22907;23042.539149217257;23221;1114.3481063577735;1123.337231033694;1123.8201887697928;1128.0975219824109;1132.365875109941;12043;12079.516819327304;15506.767398489032;15751.291191896393;16101.597460063358;225748;227330;227941;228259;228610;54249.45750542444;54638;54743;54783.726081370136;54813.451865481635;1437.9712405751827;1457.897947143711;1471.4334981032166;1476.497990683173;1490.4336352186099;26257.868710656323;26714.59928101041;27743.58384624192;28367.29081772972;28621;50186.247206291206;50757;50763;50776.23835642542;50853;203330;203442;204296;204413;204630.93053604505;35083.824580876935;36094.8195259022;36892.63107368892;36959;36978.260434790616;45531.54468455273;45673.086538269716;45755;46048;46839.29741053819;33565.83217083899;33610.15974600557;33848.3230335387;34199;34304.14239643929;32718.182045449055;32832.83583582067;33063.50404743883;33133.66866331306;33792;37383.81308093442;37428.251434971695;37740.2451950965;37808.62191378051;37887.81056094702;33069;33194;34470.93174409543;34474.65525344714;34631.82684086564;24864.12975545847;25177.622335664615;25269.368265793502;25557.083218758296;25639.487210255316 16:03:24 INFO - PID 18182 | |2;jquery.html;554.9833504994851;569.9629524080934;571.1233256950582;571.7855804073472;591.704147926037;21977.560448791035;22725.659115113285;22733.090676372947;22744.65883011756;22758.65862012067;23572.410689732766;23749.881250593768;24018;25174.87412562939;25337.493250134987;6351.904721429182;6528.673566321689;6530.477561795069;6538.934610653904;6547.869042619145;6433.099366088728;6488.091667166577;6535.281119076898;6535.705893234792;6794.898076528832;6751.493637977172;6753.290904455035;6753.594784312957;6756.560823546453;6757.526973111884;6752.088468056823;6753.628550429725;6754.358335958076;6754.560953538029;6757.391834734873;5907.6160049597065;6119.204503414572;6151.784687535915;6247.156633854417;6253.593516421418;28801;29456.70543294561;29462.558061629094;29522.70477295221;29583.260418489495;2039.1741344755399;2074.294739788479;2080.8855512946784;2081.198738485679;2082.125507286943;19324.227030918748;19700.80299197004;20017.29939452127;20101.8994905026;20135.597288054156;2319.478117423583;2322.2452702871465;2361.1499860050367;2371.2649078785457;2374.1571742031674;118784;124689.37655311666;129587.35206324002;134972.32513837368;138091;14604.83578140005;14703.705925881637;14815.406984006488;14962.625934351729;15543.766843497357;22780.20269290567;22829.657555136688;22867.370252420853;22968.19611313596;23029;9653.696750938534;9703.563339649732;9712.417254964583;9743.269254805919;9837.458939758382;8825.955870220736;8871.689490867788;8963.731088067369;9000.729978100668;9017;9080.182783549511;9224.7693807654;9395.57719902606;9462.148406643435;9531.094546018256;2641.616965539986;2663.2143517662334;2700.8919643214053;2732.319623431615;2738.986305068462;954.4750387286964;967.7580604848788;969.3263182088522;972.8832540095234;976.1507488485064;19363.709544356847;19538.902305488667;19767.209311627663;19844.107015184352;19977.800221997884;983.8917719050899;1022.8516865054675;1029.7477118105962;1033.3541536539663;1052.9789404212027;10820.67537973862;11313.943430282796;13452.461901524026;13708;14256.287185640884;479979;490476;492961;496573;500069;119164;129485.35257323654;132933;133144;133255;1192.9582464613698;1223.626793827891;1243.9426487485564;1259.5276771210797;1260.791969325051;21424.143034278455;21592.67610985805;21636.89181554082;21831.345059648236;22198.88900555487;61421.38578614157;61653.38346616656;61920.380796191464;62425.37574624195;65013.674931626934;76282.9486820521;76793.61603191949;77280;77395;77514.6124269375;19756.50608734793;20251.18995240174;20322.390328290174;20334.491637709176;20353.084111214735;23026.424339391648;23320.183793567143;23378.18176363819;23441.296761097194;23513.059477620704;18031;18257.45227643173;18344.541386465444;18465.353712619995;18487.630247395246;16415.83584164143;16501.33994640201;16551.172441378123;16636.08501532427;16928;19352.4194274172;19772.802271977096;19924.90037549803;19950.102245398703;20039.499012524804;20074;20391.59216815685;20599.485012874797;20719.27482538104;20726.170953161705;17296.135193240036;18506.352277670216;18514.351997680016;18714.06429678538;18779.718304225175 16:03:24 INFO - PID 18182 | |3;mootools.html;1338.1970817509496;1381.702933869218;1411.456589213153;1415.3277193333167;1417.093060441317;14845.18351490669;15486.148261845594;15491;15505.457308994202;15519.146446945413;15159.848401515981;15272;15303.617409564766;15307.081575105502;15334.539963801077;2729.5223335916185;2754.2012816283254;2780.3605170810724;2786;2799.076304819405;2688.7176846431134;2691.663542057243;2713.5386984212732;2718.415540658758;2741.0543362539893;2685.7582817546418;2718.972810271902;2835.4470878178763;2836.61705669734;2837.3899611583506;2796.1891051595117;2808.6348774659264;2830.3914658348554;2830.5754136879427;2835.4470878178763;2659.255408485627;2661.614065960425;2667.493176296517;2671.6526851509375;2675.264302316859;14837.777433338508;14922.62693432662;14930.402783888632;14941.17823519706;15202.315895784715;7593.202713715035;7810.492317999312;7869.960650196713;7880.4877682951;7898.960505197438;5073.34046573943;5215.739213039333;5250.44870288618;5374.731263436852;5382.730863456851;1893.3184053740642;1900.1449347793548;1931.8357939575153;1956.2468449646988;1970.0642194957425;25955.221343359728;26099.608505872427;26143.73856261451;26238.86880565585;26271.868640656674;6638.402543771083;6837.453003759687;6893.75871844483;7032;7046.224915259318;17308.221130049176;17328.48014559565;17330.480085597454;17338.3064677414;17339.65320693579;7855.175206603339;8001.999750031246;8028.59857007159;8030.598470076473;8038.598070096472;7181.353678168885;7287.307705767944;7384.409247260206;7419.29516695913;7445.7766267012075;5026.271190677331;5241.659292145999;5254.7898084076205;5262.210668399694;5270.868228294246;1273.3378643105718;1319.8614145514775;1361.9591412257648;1385.7713477276338;1440.6758479342063;855.6919508976763;875.3347455933537;890.2610833008588;893.0221407558713;895.583553647557;8423.536705481258;8731.15420941371;8751.518666473277;8755.299576033902;8857;981.7594689301167;995.3082607587802;1006.1598565198142;1017.1913328903539;1018.8420794776821;4878.268259761065;5528.612997090165;5722.914156287659;5964.194833697482;6012.579119461596;22205.888970555043;22218.222362217246;22453;22501.32496025122;22649.2072777452;20988.89505552493;22205.888970555367;22420.32739017832;22526;22562.435939101655;11480.483378247998;11730.178887477794;11730.178887477965;11734.295942243492;11795.469203885847;8431.620577073923;9152.405093668891;9213.894332680122;9224.815503690023;9273.397229180082;18344.541386465444;18866.434006979813;18942.242310307985;19006.239750410383;19127.13927873221;19130.330438434587;19187.232510699414;19524.9023754886;19663.41009769709;19756.11097500587;12343.567975120828;12552.748945020865;12614.49542018309;12618.87381126177;12625.305608191638;14166.220857852917;14208.360623771749;14234.430622774973;14257;14343.139411634918;11698.415079246173;11727.589534366256;11751.706207344885;11784.469698863742;11958;11270.549178032787;11376.772464550828;11464.31214127155;11658.65024049246;11845;10330.121939634915;10463.110635595755;10491.737706557396;10499;10502.68491945243;7618.428617853572;7636.923630763621;7670.923290767021;7746.57393843344;7788.766337009899;7523.849523009619;7600.201978792368;7647.38820894316;7681.385489160965;7691 16:03:24 INFO - PID 18182 | |4;prototype.html;502.2817371159241;516.491256112729;517.226746014708;528.8334174734958;532.8747744280093;6043.153958445821;6061.909071363933;6165.753369865211;6172.135900973862;6204.069389591558;5974.432428919256;6051.848703782408;6125.203723515937;6134.4478996890275;6184.484801223706;4877.146499362598;5034.446210916796;5044.142495775727;5107.752588860908;5107.7956881724685;4946.675062720516;4957.702537847723;5017.172166592526;5065.265536497206;5067.543921047105;4882.536159064901;4912.754362281889;4940.481249468808;4951.712554735776;4983.875403114915;4896.2410826321975;4904.800911034315;4909.422553159584;4969.552740253358;4976.129177393942;4465.888352791174;4475.932861007088;4477.395551600524;4477.440319960005;4529.547045295477;6170.629762214281;6184.319724830265;6196.535259855529;6211.223597050369;6230.314665386803;5653.689047102408;5655.434456554352;5665.5184309333345;5677.489025987639;5684.687342196177;6432.45324147448;6460.321666225026;6478.7084581193485;6537.869242615121;6577.309382514815;4847.684900481458;4867.586255168315;4867.70793752376;4885.316055752198;4915.877103072416;6716.630585317855;6794.830129246759;6812.807758642218;6847.554908930953;6870.931290687079;4967.105920934194;4971.6271279654175;4976.477469865685;4979.925301120486;5015.141369419396;5077.111505486599;5078.949210507848;5079.450767515943;5096.617753668415;5116.386033675983;5562.554995600342;5608.523275521627;5623.746931388016;5648.898464799325;5650.180723795109;6238.812835614939;6346.17499725042;6425.646589437532;6485.837854053686;6568.901466477911;1648.8351164883657;1727.0053088682591;1734.3409504388503;1737.426649205759;1753.1497223846425;1187.7921363761307;1207.2153100484754;1221.9694507637203;1237.3132911234352;1237.6534570320325;5618.634788738719;5686.914696279559;5748.626339287933;5750.9360768258;5751.539876809845;6628.767993120314;6639.601623902581;6705.373292428307;6761.797146085625;6793.369591298053;5673.744681489343;5698.6120687070725;5742.310922689304;5764.221830052889;5768.7692492300675;3549.396602577516;3550.3254381667402;3573.3925232710503;3578.7673801202836;3588.6183819229263;6507.967460162764;6517.315681853337;6526.934730652632;6584.604923704593;6606.339366063451;6836.418904393182;6838.965805170942;6931.376176144171;6974.476914231453;6990.895136572955;6429.517786166056;6516.869662606816;6559.967200163968;6577.769778057745;6589;6662.56693314933;6681.565698229794;6725.764598239038;6740.831479213059;6802.659867006729;6617.867642647217;6664.166979127609;6672.733090676513;6694.430973367123;6726.764563240263;6411.723838037616;6471.514636402383;6544.6910617875665;6578.144841170617;6614;4997.8250761224635;5011.792452830265;5012.348394708664;5024.397072351341;5026.824061157842;6463.321351258238;6626.768063117768;6701.698423570853;6707.966460167668;6741.426978706669;6178.66017369049;6372.107904893412;6423;6451.645154517604;6469.805905822833;6358.427741503287;6384.904226436514;6396.168498095404;6408.9038664421005;6423.261324947691;6198.194234749454;6202.596831205957;6275.184226050585;6330.145430367026;6366.872662546631;6423.454006409507;6457.225132984072;6467.159269294962;6484.5460817742305;6487.805365839033;6210.608915567449;6215.471684906834;6284.780032698834;6308.337624549356;6313.873722525615 16:03:24 INFO - PID 18182 | |5;yui.html;894.0612357025124;902.4404868981228;917.8623206519021;923.5890028937125;927.7726956895559;19705;20296.492587685316;20548.69176962345;20574.27990020346;20623.793762062374;18410.907945460254;18564.814351856476;18624.068796560186;18636.161372738225;18637.627247455075;921.8571121476165;933.2067742418958;936.8454205056157;937.105064663245;937.6155776131787;965.1362030982267;987.1362557761922;987.1757082835841;989.5645915797062;990.9058639429243;1002.939823610582;1028.8919663435345;1032.3908893752684;1036.2073014144187;1037.7820657661862;1019.4749703902496;1028.4086650176177;1028.7222449938513;1028.7890982348601;1029.130384824822;722.9819254518627;745.7315366468067;748.9400847932152;749.4603885202646;750.0511852506584;19901.303454379027;20062.699059514118;20070.698939515918;20079;20135.79864201354;21500.46248843776;21657.56684866294;22398.104075836945;22474.550508989727;22553.54892902149;17119.572010699707;17154.313827446887;17397.565060873454;17658.823411765847;17758.378456754082;3697.2235830475634;3741.981290093532;3745.8501659933568;3747.9812600937094;3750.043738846604;98816;139797.3010134953;140326;141048.29475852658;143402;17579.12104394775;17811.821881781274;17903.28386864537;18027.639447211244;18031.368902088627;30440.238994025327;31281.374372512422;31361.686383136333;31479;31485.842570787;9022.413543119676;9177.632894684271;9231.169194772503;9312.34813563044;9372.67195648149;4272.5727427257025;4376.606105450524;4378.036831896978;4384.56154384559;4385.386045953569;5510.8071217507195;5542.057850165482;5613.101903695389;5621.7751289948765;5638.830835074954;1017.5573625472795;1039.1167507618463;1039.2828948025838;1040.6097713357492;1052.9684109476727;681.1655721740926;695.3290075077473;696.9616671083139;704.7075463682617;718.8346680263569;11930.821037684442;12041.879581204075;12114.939425302993;13360.866391335961;13465.798013029616;613.6992873492046;625.2965413909352;626.3110578363763;630.2437075509407;636.8503401700597;5715.657060576295;5849.590528663038;5929.3181284152015;6010.459058684739;6087.05650624154;122569;124375.3781231088;124469;124799;125228.37385813195;108502.45748771206;108633;108797;112190;114346;91453;93389.53305233567;97778.51110744543;99591.50204248933;99695;12527.686807829512;12776.808347874603;12940.352982350656;13050.738985220052;13197.142185757895;42731.57268427276;43683.344749828146;43807.34288985732;43874.341884871115;44124.55875441204;75439;77875.2212477868;78075;78598.21401785909;78990;18725.157367918204;19271.807281927002;19392.8060719391;19433.708494372313;19696.704549431484;21739;22222.333330000125;22471.32586022422;22722;22760.772392275867;17513.387031453836;17939.820601793814;17975.370862019765;18525.351612693492;20311.695324569846;19523;20102.89948550248;20167.798322017177;20579.58840823145;20869.686954695997;18814.717779233048;18943.242270309034;19143;20057.498562536053;20352.08415621271;12654.810177847156;12880.484780609046;13037.869621303666;13607.455701772215;14393.496227631982;14106.647333816327;14238.857611423753;15081.321340539922;15585.454509092127;15725.606859828138 16:03:24 INFO - PID 18182 | __end_tp_report 16:03:24 INFO - PID 18182 | __start_cc_report 16:03:24 INFO - PID 18182 | _x_x_mozilla_cycle_collect,379 16:03:24 INFO - PID 18182 | __end_cc_report 16:03:24 INFO - PID 18182 | __startTimestamp1504825404130__endTimestamp 16:03:24 INFO - PID 18182 | 16:03:24 INFO - PID 18182 | ------- Summary: start ------- 16:03:24 INFO - PID 18182 | Number of tests: 6 16:03:24 INFO - PID 18182 | 16:03:24 INFO - PID 18182 | [#0] dojo.html Cycles:165 Average:6206.19 Median:6477.31 stddev:762.53 (11.8%) stddev-sans-first:723.96 16:03:24 INFO - PID 18182 | Values: 3065.0 3088.7 3099.7 3104.3 3114.7 6301.4 6401.6 6431.5 6435.5 6437.3 6156.2 6292.9 6293.2 6301.1 6313.0 5808.4 5862.9 5874.8 5890.6 5898.0 5560.3 5792.9 5863.2 5882.7 5893.0 5672.7 5687.9 5770.2 5807.9 5842.4 5767.0 5779.9 5848.3 5862.4 5890.9 5584.2 5655.7 5676.5 5771.6 5822.0 6312.4 6322.1 6353.9 6361.6 6372.1 6693.3 6744.6 6829.1 6839.9 6843.6 6752.6 6809.5 6816.6 6906.9 6907.5 6313.5 6320.6 6346.7 6357.3 6359.9 6835.3 6983.5 7002.8 7018.8 7032.9 6615.0 6647.6 6683.0 6722.5 6760.6 6502.0 6598.6 6626.6 6774.2 6863.5 6637.7 6660.6 6683.7 6703.1 6733.9 6574.0 6637.2 6751.0 6751.3 6779.6 5126.7 5193.2 5198.7 5201.5 5202.5 4574.9 4616.1 4641.9 4645.2 4648.6 5826.9 5870.6 5893.3 5899.1 5910.8 6614.3 6700.0 6715.0 6778.8 6871.7 5746.5 5753.9 5769.7 5773.5 5830.1 5711.3 5769.3 5819.3 5840.9 5843.6 6471.6 6486.2 6577.8 6580.7 6658.5 6510.9 6773.2 6787.9 6878.9 6888.0 6445.2 6565.5 6573.4 6592.4 6637.9 6653.3 6693.5 6729.0 6767.9 6809.8 6783.2 6804.9 6807.2 6871.8 6873.0 6300.4 6477.7 6483.0 6484.0 6597.3 6560.5 6577.5 6597.2 6605.7 6646.4 6477.3 6478.6 6480.5 6564.2 6575.5 6439.3 6582.3 6630.7 6633.0 6714.0 6323.4 6378.1 6469.6 6483.5 6507.7 16:03:24 INFO - PID 18182 | 16:03:24 INFO - PID 18182 | [#1] ext.html Cycles:180 Average:38101.99 Median:19803.50 stddev:53209.52 (268.7%) stddev-sans-first:53285.23 16:03:24 INFO - PID 18182 | Values: 839.9 840.2 858.7 860.1 873.1 37840.0 41039.2 41304.2 41440.6 41519.0 37087.8 37399.6 37442.6 37442.8 37510.4 7025.8 7751.1 7950.8 7954.4 7954.6 7727.5 7831.5 7839.3 7842.5 7845.0 7852.2 7900.5 7908.5 7910.2 7914.4 7833.6 7866.4 7867.6 7873.8 7880.8 7774.0 7777.1 7781.6 7814.8 7820.3 37192.0 37424.4 37455.4 37487.8 37506.6 3477.2 3493.7 3498.4 3508.0 3512.2 31237.8 31465.5 31486.1 31543.7 31582.4 5241.4 5243.0 5247.1 5279.6 5294.0 181516.0 182118.0 182887.0 183415.1 183996.0 40830.2 41729.4 47331.3 47951.0 48032.8 44422.6 44451.3 51071.5 51653.0 51841.0 14987.4 15298.3 15299.2 15318.3 15320.2 12309.9 12339.1 12340.2 12341.3 12344.6 14274.4 14304.9 14311.7 14383.4 14457.5 5769.4 5846.4 5909.3 5974.7 6040.2 1002.1 1010.2 1022.3 1026.8 1044.4 22623.3 22843.7 22907.0 23042.5 23221.0 1114.3 1123.3 1123.8 1128.1 1132.4 12043.0 12079.5 15506.8 15751.3 16101.6 225748.0 227330.0 227941.0 228259.0 228610.0 54249.5 54638.0 54743.0 54783.7 54813.5 1438.0 1457.9 1471.4 1476.5 1490.4 26257.9 26714.6 27743.6 28367.3 28621.0 50186.2 50757.0 50763.0 50776.2 50853.0 203330.0 203442.0 204296.0 204413.0 204630.9 35083.8 36094.8 36892.6 36959.0 36978.3 45531.5 45673.1 45755.0 46048.0 46839.3 33565.8 33610.2 33848.3 34199.0 34304.1 32718.2 32832.8 33063.5 33133.7 33792.0 37383.8 37428.3 37740.2 37808.6 37887.8 33069.0 33194.0 34470.9 34474.7 34631.8 24864.1 25177.6 25269.4 25557.1 25639.5 16:03:24 INFO - PID 18182 | 16:03:24 INFO - PID 18182 | [#2] jquery.html Cycles:180 Average:35757.72 Median:2320.86 stddev:83037.90 (3577.9%) stddev-sans-first:83228.78 16:03:24 INFO - PID 18182 | Values: 555.0 570.0 571.1 571.8 591.7 21977.6 22725.7 22733.1 22744.7 22758.7 23572.4 23749.9 24018.0 25174.9 25337.5 6351.9 6528.7 6530.5 6538.9 6547.9 6433.1 6488.1 6535.3 6535.7 6794.9 6751.5 6753.3 6753.6 6756.6 6757.5 6752.1 6753.6 6754.4 6754.6 6757.4 5907.6 6119.2 6151.8 6247.2 6253.6 28801.0 29456.7 29462.6 29522.7 29583.3 2039.2 2074.3 2080.9 2081.2 2082.1 19324.2 19700.8 20017.3 20101.9 20135.6 2319.5 2322.2 2361.1 2371.3 2374.2 118784.0 124689.4 129587.4 134972.3 138091.0 14604.8 14703.7 14815.4 14962.6 15543.8 22780.2 22829.7 22867.4 22968.2 23029.0 9653.7 9703.6 9712.4 9743.3 9837.5 8826.0 8871.7 8963.7 9000.7 9017.0 9080.2 9224.8 9395.6 9462.1 9531.1 2641.6 2663.2 2700.9 2732.3 2739.0 954.5 967.8 969.3 972.9 976.2 19363.7 19538.9 19767.2 19844.1 19977.8 983.9 1022.9 1029.7 1033.4 1053.0 10820.7 11313.9 13452.5 13708.0 14256.3 479979.0 490476.0 492961.0 496573.0 500069.0 119164.0 129485.4 132933.0 133144.0 133255.0 1193.0 1223.6 1243.9 1259.5 1260.8 21424.1 21592.7 21636.9 21831.3 22198.9 61421.4 61653.4 61920.4 62425.4 65013.7 76282.9 76793.6 77280.0 77395.0 77514.6 19756.5 20251.2 20322.4 20334.5 20353.1 23026.4 23320.2 23378.2 23441.3 23513.1 18031.0 18257.5 18344.5 18465.4 18487.6 16415.8 16501.3 16551.2 16636.1 16928.0 19352.4 19772.8 19924.9 19950.1 20039.5 20074.0 20391.6 20599.5 20719.3 20726.2 17296.1 18506.4 18514.4 18714.1 18779.7 16:03:24 INFO - PID 18182 | 16:03:24 INFO - PID 18182 | [#3] mootools.html Cycles:180 Average:9547.68 Median:26191.30 stddev:6759.94 (25.8%) stddev-sans-first:6750.77 16:03:24 INFO - PID 18182 | Values: 1338.2 1381.7 1411.5 1415.3 1417.1 14845.2 15486.1 15491.0 15505.5 15519.1 15159.8 15272.0 15303.6 15307.1 15334.5 2729.5 2754.2 2780.4 2786.0 2799.1 2688.7 2691.7 2713.5 2718.4 2741.1 2685.8 2719.0 2835.4 2836.6 2837.4 2796.2 2808.6 2830.4 2830.6 2835.4 2659.3 2661.6 2667.5 2671.7 2675.3 14837.8 14922.6 14930.4 14941.2 15202.3 7593.2 7810.5 7870.0 7880.5 7899.0 5073.3 5215.7 5250.4 5374.7 5382.7 1893.3 1900.1 1931.8 1956.2 1970.1 25955.2 26099.6 26143.7 26238.9 26271.9 6638.4 6837.5 6893.8 7032.0 7046.2 17308.2 17328.5 17330.5 17338.3 17339.7 7855.2 8002.0 8028.6 8030.6 8038.6 7181.4 7287.3 7384.4 7419.3 7445.8 5026.3 5241.7 5254.8 5262.2 5270.9 1273.3 1319.9 1362.0 1385.8 1440.7 855.7 875.3 890.3 893.0 895.6 8423.5 8731.2 8751.5 8755.3 8857.0 981.8 995.3 1006.2 1017.2 1018.8 4878.3 5528.6 5722.9 5964.2 6012.6 22205.9 22218.2 22453.0 22501.3 22649.2 20988.9 22205.9 22420.3 22526.0 22562.4 11480.5 11730.2 11730.2 11734.3 11795.5 8431.6 9152.4 9213.9 9224.8 9273.4 18344.5 18866.4 18942.2 19006.2 19127.1 19130.3 19187.2 19524.9 19663.4 19756.1 12343.6 12552.7 12614.5 12618.9 12625.3 14166.2 14208.4 14234.4 14257.0 14343.1 11698.4 11727.6 11751.7 11784.5 11958.0 11270.5 11376.8 11464.3 11658.7 11845.0 10330.1 10463.1 10491.7 10499.0 10502.7 7618.4 7636.9 7670.9 7746.6 7788.8 7523.8 7600.2 7647.4 7681.4 7691.0 16:03:24 INFO - PID 18182 | 16:03:24 INFO - PID 18182 | [#4] prototype.html Cycles:180 Average:5480.71 Median:6150.10 stddev:1530.95 (24.9%) stddev-sans-first:1488.95 16:03:24 INFO - PID 18182 | Values: 502.3 516.5 517.2 528.8 532.9 6043.2 6061.9 6165.8 6172.1 6204.1 5974.4 6051.8 6125.2 6134.4 6184.5 4877.1 5034.4 5044.1 5107.8 5107.8 4946.7 4957.7 5017.2 5065.3 5067.5 4882.5 4912.8 4940.5 4951.7 4983.9 4896.2 4904.8 4909.4 4969.6 4976.1 4465.9 4475.9 4477.4 4477.4 4529.5 6170.6 6184.3 6196.5 6211.2 6230.3 5653.7 5655.4 5665.5 5677.5 5684.7 6432.5 6460.3 6478.7 6537.9 6577.3 4847.7 4867.6 4867.7 4885.3 4915.9 6716.6 6794.8 6812.8 6847.6 6870.9 4967.1 4971.6 4976.5 4979.9 5015.1 5077.1 5078.9 5079.5 5096.6 5116.4 5562.6 5608.5 5623.7 5648.9 5650.2 6238.8 6346.2 6425.6 6485.8 6568.9 1648.8 1727.0 1734.3 1737.4 1753.1 1187.8 1207.2 1222.0 1237.3 1237.7 5618.6 5686.9 5748.6 5750.9 5751.5 6628.8 6639.6 6705.4 6761.8 6793.4 5673.7 5698.6 5742.3 5764.2 5768.8 3549.4 3550.3 3573.4 3578.8 3588.6 6508.0 6517.3 6526.9 6584.6 6606.3 6836.4 6839.0 6931.4 6974.5 6990.9 6429.5 6516.9 6560.0 6577.8 6589.0 6662.6 6681.6 6725.8 6740.8 6802.7 6617.9 6664.2 6672.7 6694.4 6726.8 6411.7 6471.5 6544.7 6578.1 6614.0 4997.8 5011.8 5012.3 5024.4 5026.8 6463.3 6626.8 6701.7 6708.0 6741.4 6178.7 6372.1 6423.0 6451.6 6469.8 6358.4 6384.9 6396.2 6408.9 6423.3 6198.2 6202.6 6275.2 6330.1 6366.9 6423.5 6457.2 6467.2 6484.5 6487.8 6210.6 6215.5 6284.8 6308.3 6313.9 16:03:24 INFO - PID 18182 | 16:03:24 INFO - PID 18182 | [#5] yui.html Cycles:180 Average:25646.67 Median:20576.93 stddev:35574.12 (172.9%) stddev-sans-first:35625.36 16:03:24 INFO - PID 18182 | Values: 894.1 902.4 917.9 923.6 927.8 19705.0 20296.5 20548.7 20574.3 20623.8 18410.9 18564.8 18624.1 18636.2 18637.6 921.9 933.2 936.8 937.1 937.6 965.1 987.1 987.2 989.6 990.9 1002.9 1028.9 1032.4 1036.2 1037.8 1019.5 1028.4 1028.7 1028.8 1029.1 723.0 745.7 748.9 749.5 750.1 19901.3 20062.7 20070.7 20079.0 20135.8 21500.5 21657.6 22398.1 22474.6 22553.5 17119.6 17154.3 17397.6 17658.8 17758.4 3697.2 3742.0 3745.9 3748.0 3750.0 98816.0 139797.3 140326.0 141048.3 143402.0 17579.1 17811.8 17903.3 18027.6 18031.4 30440.2 31281.4 31361.7 31479.0 31485.8 9022.4 9177.6 9231.2 9312.3 9372.7 4272.6 4376.6 4378.0 4384.6 4385.4 5510.8 5542.1 5613.1 5621.8 5638.8 1017.6 1039.1 1039.3 1040.6 1053.0 681.2 695.3 697.0 704.7 718.8 11930.8 12041.9 12114.9 13360.9 13465.8 613.7 625.3 626.3 630.2 636.9 5715.7 5849.6 5929.3 6010.5 6087.1 122569.0 124375.4 124469.0 124799.0 125228.4 108502.5 108633.0 108797.0 112190.0 114346.0 91453.0 93389.5 97778.5 99591.5 99695.0 12527.7 12776.8 12940.4 13050.7 13197.1 42731.6 43683.3 43807.3 43874.3 44124.6 75439.0 77875.2 78075.0 78598.2 78990.0 18725.2 19271.8 19392.8 19433.7 19696.7 21739.0 22222.3 22471.3 22722.0 22760.8 17513.4 17939.8 17975.4 18525.4 20311.7 19523.0 20102.9 20167.8 20579.6 20869.7 18814.7 18943.2 19143.0 20057.5 20352.1 12654.8 12880.5 13037.9 13607.5 14393.5 14106.6 14238.9 15081.3 15585.5 15725.6 16:03:24 INFO - PID 18182 | -------- Summary: end -------- 16:03:24 INFO - PID 18182 | 16:03:24 INFO - TEST-INFO | 18182: exit 0 16:03:24 INFO - TEST-OK | dromaeo_css | took 1107613ms 16:03:24 INFO - TEST-START | kraken 16:03:24 INFO - Initialising browser for kraken test... 16:03:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51776/getInfo.html -profile /tmp/tmpm29ThB/profile 16:03:24 INFO - TEST-INFO | started process 18558 (/builds/slave/test/build/application/firefox/firefox http://localhost:51776/getInfo.html) 16:03:29 INFO - TEST-INFO | 18558: exit 0 16:03:29 INFO - Browser initialized. 16:03:29 INFO - Running cycle 1/1 for kraken test... 16:03:29 INFO - Using env: {'DISPLAY': ':0', 16:03:29 INFO - 'HOME': '/home/cltbld', 16:03:29 INFO - 'JSGC_DISABLE_POISONING': '1', 16:03:29 INFO - 'LANG': 'en_US.UTF-8', 16:03:29 INFO - 'LANGUAGE': 'en_US:en', 16:03:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:03:29 INFO - 'LOGNAME': 'cltbld', 16:03:29 INFO - 'MAIL': '/var/mail/cltbld', 16:03:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:03:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:03:29 INFO - 'MOZ_CRASHREPORTER': '1', 16:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:03:29 INFO - 'MOZ_NO_REMOTE': '1', 16:03:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:03:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:29 INFO - 'NO_EM_RESTART': '1', 16:03:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:29 INFO - 'PWD': '/builds/slave/test', 16:03:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:03:29 INFO - 'RUST_BACKTRACE': 'full', 16:03:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:03:29 INFO - 'SHELL': '/bin/bash', 16:03:29 INFO - 'SHLVL': '1', 16:03:29 INFO - 'STYLO_FORCE_ENABLED': '1', 16:03:29 INFO - 'STYLO_THREADS': '1', 16:03:29 INFO - 'TERM': 'linux', 16:03:29 INFO - 'TMOUT': '86400', 16:03:29 INFO - 'USER': 'cltbld', 16:03:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687', 16:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:29 INFO - '_': '/tools/buildbot/bin/python'} 16:03:29 INFO - TEST-INFO | started process 18741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm29ThB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:03:30 INFO - PID 18741 | 16:03:30 INFO - PID 18741 | (/builds/slave/test/build/application/firefox/firefox:18792): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:03:30 INFO - PID 18741 | 16:03:40 INFO - PID 18741 | RSS: Main: 172265472 16:03:40 INFO - PID 18741 | 16:03:43 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51776/tests/kraken/driver.html?testName=audio-beat-detection) 16:03:44 INFO - PID 18741 | RSS: Main: 178122752 16:03:44 INFO - PID 18741 | 16:03:47 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51776/tests/kraken/driver.html?testName=audio-dft) 16:03:47 INFO - PID 18741 | RSS: Main: 178937856 16:03:47 INFO - PID 18741 | 16:03:50 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51776/tests/kraken/driver.html?testName=audio-fft) 16:03:51 INFO - PID 18741 | RSS: Main: 173326336 16:03:51 INFO - PID 18741 | 16:03:53 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51776/tests/kraken/driver.html?testName=audio-oscillator) 16:03:54 INFO - PID 18741 | RSS: Main: 173936640 16:03:54 INFO - PID 18741 | 16:03:56 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51776/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:03:56 INFO - PID 18741 | RSS: Main: 174313472 16:03:56 INFO - PID 18741 | 16:04:00 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51776/tests/kraken/driver.html?testName=imaging-darkroom) 16:04:00 INFO - PID 18741 | RSS: Main: 176541696 16:04:00 INFO - PID 18741 | 16:04:04 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51776/tests/kraken/driver.html?testName=imaging-desaturate) 16:04:04 INFO - PID 18741 | RSS: Main: 176693248 16:04:04 INFO - PID 18741 | 16:04:07 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51776/tests/kraken/driver.html?testName=json-parse-financial) 16:04:08 INFO - PID 18741 | RSS: Main: 176648192 16:04:08 INFO - PID 18741 | 16:04:10 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51776/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:04:10 INFO - PID 18741 | RSS: Main: 176398336 16:04:10 INFO - PID 18741 | 16:04:12 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51776/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:04:12 INFO - PID 18741 | RSS: Main: 177029120 16:04:12 INFO - PID 18741 | 16:04:15 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51776/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:04:15 INFO - PID 18741 | RSS: Main: 173793280 16:04:15 INFO - PID 18741 | 16:04:18 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51776/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:04:19 INFO - PID 18741 | RSS: Main: 174419968 16:04:19 INFO - PID 18741 | 16:04:22 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51776/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:04:22 INFO - PID 18741 | RSS: Main: 173912064 16:04:22 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | Cycle 1(1): loaded http://localhost:51776/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51776/tests/kraken/driver.html?testName=ai-astar) 16:04:24 INFO - PID 18741 | RSS: Main: 176099328 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | __start_tp_report 16:04:24 INFO - PID 18741 | _x_x_mozilla_page_load 16:04:24 INFO - PID 18741 | _x_x_mozilla_page_load_details 16:04:24 INFO - PID 18741 | |i|pagename|runs| 16:04:24 INFO - PID 18741 | |0;ai-astar;107;106;106;107;110;98;107;106;108;108 16:04:24 INFO - PID 18741 | |1;audio-beat-detection;120;121;116;120;117;120;116;119;116;116 16:04:24 INFO - PID 18741 | |2;audio-dft;163;162;160;164;162;166;166;168;164;169 16:04:24 INFO - PID 18741 | |3;audio-fft;76;74;73;76;77;78;74;73;88;75 16:04:24 INFO - PID 18741 | |4;audio-oscillator;80;78;79;79;80;80;79;80;79;79 16:04:24 INFO - PID 18741 | |5;imaging-gaussian-blur;117;115;113;114;113;114;114;115;114;118 16:04:24 INFO - PID 18741 | |6;imaging-darkroom;150;147;148;148;147;147;148;150;151;151 16:04:24 INFO - PID 18741 | |7;imaging-desaturate;94;94;93;93;94;99;94;94;95;95 16:04:24 INFO - PID 18741 | |8;json-parse-financial;56;52;52;52;53;53;52;52;53;53 16:04:24 INFO - PID 18741 | |9;json-stringify-tinderbox;39;38;38;38;39;38;39;39;38;38 16:04:24 INFO - PID 18741 | |10;stanford-crypto-aes;76;76;77;74;76;74;77;75;77;76 16:04:24 INFO - PID 18741 | |11;stanford-crypto-ccm;132;121;116;120;120;112;126;115;119;121 16:04:24 INFO - PID 18741 | |12;stanford-crypto-pbkdf2;168;176;174;169;170;181;168;168;170;170 16:04:24 INFO - PID 18741 | |13;stanford-crypto-sha256-iterative;69;68;64;65;69;68;65;70;63;67 16:04:24 INFO - PID 18741 | __end_tp_report 16:04:24 INFO - PID 18741 | __start_cc_report 16:04:24 INFO - PID 18741 | _x_x_mozilla_cycle_collect,919 16:04:24 INFO - PID 18741 | __end_cc_report 16:04:24 INFO - PID 18741 | __startTimestamp1504825464749__endTimestamp 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | ------- Summary: start ------- 16:04:24 INFO - PID 18741 | Number of tests: 14 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#0] ai-astar Cycles:10 Average:106.30 Median:107.50 stddev:3.16 (2.9%) stddev-sans-first:3.35 16:04:24 INFO - PID 18741 | Values: 107.0 106.0 106.0 107.0 110.0 98.0 107.0 106.0 108.0 108.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#1] audio-beat-detection Cycles:10 Average:118.10 Median:119.50 stddev:2.08 (1.7%) stddev-sans-first:2.09 16:04:24 INFO - PID 18741 | Values: 120.0 121.0 116.0 120.0 117.0 120.0 116.0 119.0 116.0 116.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:2.84 (1.7%) stddev-sans-first:2.96 16:04:24 INFO - PID 18741 | Values: 163.0 162.0 160.0 164.0 162.0 166.0 166.0 168.0 164.0 169.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#3] audio-fft Cycles:10 Average:76.40 Median:76.00 stddev:4.40 (5.8%) stddev-sans-first:4.67 16:04:24 INFO - PID 18741 | Values: 76.0 74.0 73.0 76.0 77.0 78.0 74.0 73.0 88.0 75.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:79.50 stddev:0.67 (0.8%) stddev-sans-first:0.67 16:04:24 INFO - PID 18741 | Values: 80.0 78.0 79.0 79.0 80.0 80.0 79.0 80.0 79.0 79.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.64 (1.4%) stddev-sans-first:1.51 16:04:24 INFO - PID 18741 | Values: 117.0 115.0 113.0 114.0 113.0 114.0 114.0 115.0 114.0 118.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.64 (1.1%) stddev-sans-first:1.67 16:04:24 INFO - PID 18741 | Values: 150.0 147.0 148.0 148.0 147.0 147.0 148.0 150.0 151.0 151.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.72 (1.8%) stddev-sans-first:1.81 16:04:24 INFO - PID 18741 | Values: 94.0 94.0 93.0 93.0 94.0 99.0 94.0 94.0 95.0 95.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.23 (2.3%) stddev-sans-first:0.53 16:04:24 INFO - PID 18741 | Values: 56.0 52.0 52.0 52.0 53.0 53.0 52.0 52.0 53.0 53.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#9] json-stringify-tinderbox Cycles:10 Average:38.40 Median:38.50 stddev:0.52 (1.3%) stddev-sans-first:0.50 16:04:24 INFO - PID 18741 | Values: 39.0 38.0 38.0 38.0 39.0 38.0 39.0 39.0 38.0 38.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:1.14 (1.5%) stddev-sans-first:1.20 16:04:24 INFO - PID 18741 | Values: 76.0 76.0 77.0 74.0 76.0 74.0 77.0 75.0 77.0 76.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:120.50 stddev:5.65 (4.7%) stddev-sans-first:4.08 16:04:24 INFO - PID 18741 | Values: 132.0 121.0 116.0 120.0 120.0 112.0 126.0 115.0 119.0 121.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:170.00 stddev:4.30 (2.5%) stddev-sans-first:4.38 16:04:24 INFO - PID 18741 | Values: 168.0 176.0 174.0 169.0 170.0 181.0 168.0 168.0 170.0 170.0 16:04:24 INFO - PID 18741 | 16:04:24 INFO - PID 18741 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:68.00 stddev:2.39 (3.5%) stddev-sans-first:2.40 16:04:24 INFO - PID 18741 | Values: 69.0 68.0 64.0 65.0 69.0 68.0 65.0 70.0 63.0 67.0 16:04:24 INFO - PID 18741 | -------- Summary: end -------- 16:04:24 INFO - PID 18741 | 16:04:25 INFO - PID 18741 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:04:25 INFO - TEST-INFO | 18741: exit 0 16:04:25 INFO - TEST-OK | kraken | took 60669ms 16:04:25 INFO - SUITE-END | took 1168s 16:04:25 INFO - Completed test suite (00:19:28) 16:04:25 INFO - javascript benchmark 16:04:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8702.912468397726, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.9846750766246, 3088.6602473727885, 3099.7055279748415, 3104.2549788050874, 3114.735247503962, 6301.369863013696, 6401.61590304582, 6431.485481161508, 6435.485161187105, 6437.2918978912285, 6156.168917196177, 6292.8741425171465, 6293.150424692665, 6301.117843501914, 6313.0, 5808.448197421239, 5862.912056319148, 5874.794382196624, 5890.617109887844, 5897.970510147443, 5560.277163968678, 5792.913106303409, 5863.237779088712, 5882.735276912549, 5893.0, 5672.716364181795, 5687.914681279784, 5770.2498675171955, 5807.941920580783, 5842.386549412336, 5767.0, 5779.913301300484, 5848.327442344143, 5862.443067908542, 5890.852728681774, 5584.246126772915, 5655.660660360391, 5676.460736230051, 5771.567132465082, 5822.039363505017, 6312.43188113072, 6322.083297921776, 6353.936460635381, 6361.55469117162, 6372.076048972873, 6693.263740988487, 6744.5616034957575, 6829.146356705412, 6839.897401538981, 6843.589384636938, 6752.5948443093575, 6809.489288303397, 6816.591004539743, 6906.861862762717, 6907.481938854606, 6313.463355614778, 6320.5891617044745, 6346.6509341986175, 6357.33248008957, 6359.9364006360265, 6835.282295359015, 6983.511154219156, 7002.7899163025195, 7018.7543435980515, 7032.859342813115, 6614.9669251654395, 6647.634380109043, 6683.0, 6722.495812814059, 6760.560563563451, 6501.967490162613, 6598.637074960827, 6626.56927299724, 6774.220964589037, 6863.485238607124, 6637.668116594151, 6660.600363978177, 6683.732650693918, 6703.061571380011, 6733.865322693617, 6573.967130164318, 6637.203535575762, 6751.0, 6751.291114433012, 6779.6271205084195, 5126.6923984561045, 5193.195054766517, 5198.662086964335, 5201.479852014844, 5202.505761952609, 4574.862754117382, 4616.1229366420275, 4641.860744177612, 4645.233536466445, 4648.558386953234, 5826.883462330729, 5870.618409803349, 5893.322267939242, 5899.144624029492, 5910.822675319747, 6614.338566143347, 6699.9665001674675, 6714.966425167843, 6778.796636100925, 6871.725130994704, 5746.454086861741, 5753.942460575341, 5769.711514424346, 5773.480386765212, 5830.125481177857, 5711.257536520226, 5769.278840144982, 5819.272590926134, 5840.912386314209, 5843.590948633555, 6471.579347342407, 6486.156799616114, 6577.835554111186, 6580.670966451658, 6658.533902626867, 6510.902336464862, 6773.187217533928, 6787.864242715217, 6878.8624227516175, 6887.965560172167, 6445.16212892321, 6565.507586930904, 6573.375529324707, 6592.406683398517, 6637.933620663925, 6653.301403352772, 6693.464522838259, 6729.0, 6767.89848152288, 6809.795706128824, 6783.152105986752, 6804.9319506804295, 6807.183138023469, 6871.8317885960505, 6873.0, 6300.369963003663, 6477.676116194078, 6482.967585162044, 6484.027395890655, 6597.340265973365, 6560.507961902781, 6577.506686998398, 6597.208334999831, 6605.669716514251, 6646.368594983469, 6477.305536473467, 6478.611283323015, 6480.513961452815, 6564.245111812012, 6575.539712220098, 6439.291677915519, 6582.275949645631, 6630.701618427279, 6633.038209459698, 6713.966430168013, 6323.36766323364, 6378.075179099097, 6469.5794773339585, 6483.481321494175, 6507.739690412331], "value": 6146.159739369081, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.9286060684841, 840.2060053249679, 858.6608289725563, 860.0926023045688, 873.0658195730567, 37840.0, 41039.17921641565, 41304.17391652165, 41440.58559414409, 41519.0, 37087.814560927225, 37399.626003739955, 37442.625573744255, 37442.81278593603, 37510.43734343987, 7025.789226323219, 7751.147373788879, 7950.801229969239, 7954.443188976774, 7954.642041108135, 7727.459077864552, 7831.530108193527, 7839.333656639193, 7842.529448233125, 7844.960775196116, 7852.21477852216, 7900.486468379566, 7908.485948413363, 7910.208979102102, 7914.366850651934, 7833.569153696544, 7866.410019248579, 7867.567283799389, 7873.842523149562, 7880.763577092696, 7774.0, 7777.105632852238, 7781.649825757854, 7814.843703125963, 7820.257075577811, 37192.0, 37424.43863342052, 37455.43816842749, 37487.81256093702, 37506.62493375059, 3477.200243943907, 3493.6506349365113, 3498.405271103893, 3508.0, 3512.1746389598425, 31237.84381078103, 31465.528017079763, 31486.055418337488, 31543.684563154304, 31582.36835263282, 5241.42344342122, 5243.030039442677, 5247.055530004598, 5279.60402969775, 5294.047071527124, 181516.0, 182118.0, 182887.0, 183415.08292458585, 183996.0, 40830.18339633191, 41729.374059389134, 47331.290030649565, 47951.0, 48032.759836201294, 44422.55577444184, 44451.333230001575, 51071.489285106676, 51653.0, 51841.0, 14987.40050397972, 15298.311575979107, 15299.235038248044, 15318.310676019606, 15320.23398830054, 12309.876901230873, 12339.13626046186, 12340.197887137307, 12341.259524428384, 12344.567940122053, 14274.357653905392, 14304.85695143056, 14311.713765724628, 14383.424663013362, 14457.49398771059, 5769.365369809318, 5846.356900740915, 5909.349971503131, 5974.731137098841, 6040.154378387029, 1002.14817405205, 1010.151472762868, 1022.3354819367471, 1026.8357062869904, 1044.4464433850071, 22623.281649616223, 22843.657345139836, 22907.0, 23042.539149217257, 23221.0, 1114.3481063577735, 1123.337231033694, 1123.8201887697928, 1128.0975219824109, 1132.365875109941, 12043.0, 12079.516819327304, 15506.767398489032, 15751.291191896393, 16101.597460063358, 225748.0, 227330.0, 227941.0, 228259.0, 228610.0, 54249.45750542444, 54638.0, 54743.0, 54783.726081370136, 54813.451865481635, 1437.9712405751827, 1457.897947143711, 1471.4334981032166, 1476.497990683173, 1490.4336352186099, 26257.868710656323, 26714.59928101041, 27743.58384624192, 28367.29081772972, 28621.0, 50186.247206291206, 50757.0, 50763.0, 50776.23835642542, 50853.0, 203330.0, 203442.0, 204296.0, 204413.0, 204630.93053604505, 35083.824580876935, 36094.8195259022, 36892.63107368892, 36959.0, 36978.260434790616, 45531.54468455273, 45673.086538269716, 45755.0, 46048.0, 46839.29741053819, 33565.83217083899, 33610.15974600557, 33848.3230335387, 34199.0, 34304.14239643929, 32718.182045449055, 32832.83583582067, 33063.50404743883, 33133.66866331306, 33792.0, 37383.81308093442, 37428.251434971695, 37740.2451950965, 37808.62191378051, 37887.81056094702, 33069.0, 33194.0, 34470.93174409543, 34474.65525344714, 34631.82684086564, 24864.12975545847, 25177.622335664615, 25269.368265793502, 25557.083218758296, 25639.487210255316], "value": 17554.404858398724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.9833504994851, 569.9629524080934, 571.1233256950582, 571.7855804073472, 591.704147926037, 21977.560448791035, 22725.659115113285, 22733.090676372947, 22744.65883011756, 22758.65862012067, 23572.410689732766, 23749.881250593768, 24018.0, 25174.87412562939, 25337.493250134987, 6351.904721429182, 6528.673566321689, 6530.477561795069, 6538.934610653904, 6547.869042619145, 6433.099366088728, 6488.091667166577, 6535.281119076898, 6535.705893234792, 6794.898076528832, 6751.493637977172, 6753.290904455035, 6753.594784312957, 6756.560823546453, 6757.526973111884, 6752.088468056823, 6753.628550429725, 6754.358335958076, 6754.560953538029, 6757.391834734873, 5907.6160049597065, 6119.204503414572, 6151.784687535915, 6247.156633854417, 6253.593516421418, 28801.0, 29456.70543294561, 29462.558061629094, 29522.70477295221, 29583.260418489495, 2039.1741344755399, 2074.294739788479, 2080.8855512946784, 2081.198738485679, 2082.125507286943, 19324.227030918748, 19700.80299197004, 20017.29939452127, 20101.8994905026, 20135.597288054156, 2319.478117423583, 2322.2452702871465, 2361.1499860050367, 2371.2649078785457, 2374.1571742031674, 118784.0, 124689.37655311666, 129587.35206324002, 134972.32513837368, 138091.0, 14604.83578140005, 14703.705925881637, 14815.406984006488, 14962.625934351729, 15543.766843497357, 22780.20269290567, 22829.657555136688, 22867.370252420853, 22968.19611313596, 23029.0, 9653.696750938534, 9703.563339649732, 9712.417254964583, 9743.269254805919, 9837.458939758382, 8825.955870220736, 8871.689490867788, 8963.731088067369, 9000.729978100668, 9017.0, 9080.182783549511, 9224.7693807654, 9395.57719902606, 9462.148406643435, 9531.094546018256, 2641.616965539986, 2663.2143517662334, 2700.8919643214053, 2732.319623431615, 2738.986305068462, 954.4750387286964, 967.7580604848788, 969.3263182088522, 972.8832540095234, 976.1507488485064, 19363.709544356847, 19538.902305488667, 19767.209311627663, 19844.107015184352, 19977.800221997884, 983.8917719050899, 1022.8516865054675, 1029.7477118105962, 1033.3541536539663, 1052.9789404212027, 10820.67537973862, 11313.943430282796, 13452.461901524026, 13708.0, 14256.287185640884, 479979.0, 490476.0, 492961.0, 496573.0, 500069.0, 119164.0, 129485.35257323654, 132933.0, 133144.0, 133255.0, 1192.9582464613698, 1223.626793827891, 1243.9426487485564, 1259.5276771210797, 1260.791969325051, 21424.143034278455, 21592.67610985805, 21636.89181554082, 21831.345059648236, 22198.88900555487, 61421.38578614157, 61653.38346616656, 61920.380796191464, 62425.37574624195, 65013.674931626934, 76282.9486820521, 76793.61603191949, 77280.0, 77395.0, 77514.6124269375, 19756.50608734793, 20251.18995240174, 20322.390328290174, 20334.491637709176, 20353.084111214735, 23026.424339391648, 23320.183793567143, 23378.18176363819, 23441.296761097194, 23513.059477620704, 18031.0, 18257.45227643173, 18344.541386465444, 18465.353712619995, 18487.630247395246, 16415.83584164143, 16501.33994640201, 16551.172441378123, 16636.08501532427, 16928.0, 19352.4194274172, 19772.802271977096, 19924.90037549803, 19950.102245398703, 20039.499012524804, 20074.0, 20391.59216815685, 20599.485012874797, 20719.27482538104, 20726.170953161705, 17296.135193240036, 18506.352277670216, 18514.351997680016, 18714.06429678538, 18779.718304225175], "value": 12394.071832776372, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.1970817509496, 1381.702933869218, 1411.456589213153, 1415.3277193333167, 1417.093060441317, 14845.18351490669, 15486.148261845594, 15491.0, 15505.457308994202, 15519.146446945413, 15159.848401515981, 15272.0, 15303.617409564766, 15307.081575105502, 15334.539963801077, 2729.5223335916185, 2754.2012816283254, 2780.3605170810724, 2786.0, 2799.076304819405, 2688.7176846431134, 2691.663542057243, 2713.5386984212732, 2718.415540658758, 2741.0543362539893, 2685.7582817546418, 2718.972810271902, 2835.4470878178763, 2836.61705669734, 2837.3899611583506, 2796.1891051595117, 2808.6348774659264, 2830.3914658348554, 2830.5754136879427, 2835.4470878178763, 2659.255408485627, 2661.614065960425, 2667.493176296517, 2671.6526851509375, 2675.264302316859, 14837.777433338508, 14922.62693432662, 14930.402783888632, 14941.17823519706, 15202.315895784715, 7593.202713715035, 7810.492317999312, 7869.960650196713, 7880.4877682951, 7898.960505197438, 5073.34046573943, 5215.739213039333, 5250.44870288618, 5374.731263436852, 5382.730863456851, 1893.3184053740642, 1900.1449347793548, 1931.8357939575153, 1956.2468449646988, 1970.0642194957425, 25955.221343359728, 26099.608505872427, 26143.73856261451, 26238.86880565585, 26271.868640656674, 6638.402543771083, 6837.453003759687, 6893.75871844483, 7032.0, 7046.224915259318, 17308.221130049176, 17328.48014559565, 17330.480085597454, 17338.3064677414, 17339.65320693579, 7855.175206603339, 8001.999750031246, 8028.59857007159, 8030.598470076473, 8038.598070096472, 7181.353678168885, 7287.307705767944, 7384.409247260206, 7419.29516695913, 7445.7766267012075, 5026.271190677331, 5241.659292145999, 5254.7898084076205, 5262.210668399694, 5270.868228294246, 1273.3378643105718, 1319.8614145514775, 1361.9591412257648, 1385.7713477276338, 1440.6758479342063, 855.6919508976763, 875.3347455933537, 890.2610833008588, 893.0221407558713, 895.583553647557, 8423.536705481258, 8731.15420941371, 8751.518666473277, 8755.299576033902, 8857.0, 981.7594689301167, 995.3082607587802, 1006.1598565198142, 1017.1913328903539, 1018.8420794776821, 4878.268259761065, 5528.612997090165, 5722.914156287659, 5964.194833697482, 6012.579119461596, 22205.888970555043, 22218.222362217246, 22453.0, 22501.32496025122, 22649.2072777452, 20988.89505552493, 22205.888970555367, 22420.32739017832, 22526.0, 22562.435939101655, 11480.483378247998, 11730.178887477794, 11730.178887477965, 11734.295942243492, 11795.469203885847, 8431.620577073923, 9152.405093668891, 9213.894332680122, 9224.815503690023, 9273.397229180082, 18344.541386465444, 18866.434006979813, 18942.242310307985, 19006.239750410383, 19127.13927873221, 19130.330438434587, 19187.232510699414, 19524.9023754886, 19663.41009769709, 19756.11097500587, 12343.567975120828, 12552.748945020865, 12614.49542018309, 12618.87381126177, 12625.305608191638, 14166.220857852917, 14208.360623771749, 14234.430622774973, 14257.0, 14343.139411634918, 11698.415079246173, 11727.589534366256, 11751.706207344885, 11784.469698863742, 11958.0, 11270.549178032787, 11376.772464550828, 11464.31214127155, 11658.65024049246, 11845.0, 10330.121939634915, 10463.110635595755, 10491.737706557396, 10499.0, 10502.68491945243, 7618.428617853572, 7636.923630763621, 7670.923290767021, 7746.57393843344, 7788.766337009899, 7523.849523009619, 7600.201978792368, 7647.38820894316, 7681.385489160965, 7691.0], "value": 6810.09528956225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.2817371159241, 516.491256112729, 517.226746014708, 528.8334174734958, 532.8747744280093, 6043.153958445821, 6061.909071363933, 6165.753369865211, 6172.135900973862, 6204.069389591558, 5974.432428919256, 6051.848703782408, 6125.203723515937, 6134.4478996890275, 6184.484801223706, 4877.146499362598, 5034.446210916796, 5044.142495775727, 5107.752588860908, 5107.7956881724685, 4946.675062720516, 4957.702537847723, 5017.172166592526, 5065.265536497206, 5067.543921047105, 4882.536159064901, 4912.754362281889, 4940.481249468808, 4951.712554735776, 4983.875403114915, 4896.2410826321975, 4904.800911034315, 4909.422553159584, 4969.552740253358, 4976.129177393942, 4465.888352791174, 4475.932861007088, 4477.395551600524, 4477.440319960005, 4529.547045295477, 6170.629762214281, 6184.319724830265, 6196.535259855529, 6211.223597050369, 6230.314665386803, 5653.689047102408, 5655.434456554352, 5665.5184309333345, 5677.489025987639, 5684.687342196177, 6432.45324147448, 6460.321666225026, 6478.7084581193485, 6537.869242615121, 6577.309382514815, 4847.684900481458, 4867.586255168315, 4867.70793752376, 4885.316055752198, 4915.877103072416, 6716.630585317855, 6794.830129246759, 6812.807758642218, 6847.554908930953, 6870.931290687079, 4967.105920934194, 4971.6271279654175, 4976.477469865685, 4979.925301120486, 5015.141369419396, 5077.111505486599, 5078.949210507848, 5079.450767515943, 5096.617753668415, 5116.386033675983, 5562.554995600342, 5608.523275521627, 5623.746931388016, 5648.898464799325, 5650.180723795109, 6238.812835614939, 6346.17499725042, 6425.646589437532, 6485.837854053686, 6568.901466477911, 1648.8351164883657, 1727.0053088682591, 1734.3409504388503, 1737.426649205759, 1753.1497223846425, 1187.7921363761307, 1207.2153100484754, 1221.9694507637203, 1237.3132911234352, 1237.6534570320325, 5618.634788738719, 5686.914696279559, 5748.626339287933, 5750.9360768258, 5751.539876809845, 6628.767993120314, 6639.601623902581, 6705.373292428307, 6761.797146085625, 6793.369591298053, 5673.744681489343, 5698.6120687070725, 5742.310922689304, 5764.221830052889, 5768.7692492300675, 3549.396602577516, 3550.3254381667402, 3573.3925232710503, 3578.7673801202836, 3588.6183819229263, 6507.967460162764, 6517.315681853337, 6526.934730652632, 6584.604923704593, 6606.339366063451, 6836.418904393182, 6838.965805170942, 6931.376176144171, 6974.476914231453, 6990.895136572955, 6429.517786166056, 6516.869662606816, 6559.967200163968, 6577.769778057745, 6589.0, 6662.56693314933, 6681.565698229794, 6725.764598239038, 6740.831479213059, 6802.659867006729, 6617.867642647217, 6664.166979127609, 6672.733090676513, 6694.430973367123, 6726.764563240263, 6411.723838037616, 6471.514636402383, 6544.6910617875665, 6578.144841170617, 6614.0, 4997.8250761224635, 5011.792452830265, 5012.348394708664, 5024.397072351341, 5026.824061157842, 6463.321351258238, 6626.768063117768, 6701.698423570853, 6707.966460167668, 6741.426978706669, 6178.66017369049, 6372.107904893412, 6423.0, 6451.645154517604, 6469.805905822833, 6358.427741503287, 6384.904226436514, 6396.168498095404, 6408.9038664421005, 6423.261324947691, 6198.194234749454, 6202.596831205957, 6275.184226050585, 6330.145430367026, 6366.872662546631, 6423.454006409507, 6457.225132984072, 6467.159269294962, 6484.5460817742305, 6487.805365839033, 6210.608915567449, 6215.471684906834, 6284.780032698834, 6308.337624549356, 6313.873722525615], "value": 5031.261328066741, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [894.0612357025124, 902.4404868981228, 917.8623206519021, 923.5890028937125, 927.7726956895559, 19705.0, 20296.492587685316, 20548.69176962345, 20574.27990020346, 20623.793762062374, 18410.907945460254, 18564.814351856476, 18624.068796560186, 18636.161372738225, 18637.627247455075, 921.8571121476165, 933.2067742418958, 936.8454205056157, 937.105064663245, 937.6155776131787, 965.1362030982267, 987.1362557761922, 987.1757082835841, 989.5645915797062, 990.9058639429243, 1002.939823610582, 1028.8919663435345, 1032.3908893752684, 1036.2073014144187, 1037.7820657661862, 1019.4749703902496, 1028.4086650176177, 1028.7222449938513, 1028.7890982348601, 1029.130384824822, 722.9819254518627, 745.7315366468067, 748.9400847932152, 749.4603885202646, 750.0511852506584, 19901.303454379027, 20062.699059514118, 20070.698939515918, 20079.0, 20135.79864201354, 21500.46248843776, 21657.56684866294, 22398.104075836945, 22474.550508989727, 22553.54892902149, 17119.572010699707, 17154.313827446887, 17397.565060873454, 17658.823411765847, 17758.378456754082, 3697.2235830475634, 3741.981290093532, 3745.8501659933568, 3747.9812600937094, 3750.043738846604, 98816.0, 139797.3010134953, 140326.0, 141048.29475852658, 143402.0, 17579.12104394775, 17811.821881781274, 17903.28386864537, 18027.639447211244, 18031.368902088627, 30440.238994025327, 31281.374372512422, 31361.686383136333, 31479.0, 31485.842570787, 9022.413543119676, 9177.632894684271, 9231.169194772503, 9312.34813563044, 9372.67195648149, 4272.5727427257025, 4376.606105450524, 4378.036831896978, 4384.56154384559, 4385.386045953569, 5510.8071217507195, 5542.057850165482, 5613.101903695389, 5621.7751289948765, 5638.830835074954, 1017.5573625472795, 1039.1167507618463, 1039.2828948025838, 1040.6097713357492, 1052.9684109476727, 681.1655721740926, 695.3290075077473, 696.9616671083139, 704.7075463682617, 718.8346680263569, 11930.821037684442, 12041.879581204075, 12114.939425302993, 13360.866391335961, 13465.798013029616, 613.6992873492046, 625.2965413909352, 626.3110578363763, 630.2437075509407, 636.8503401700597, 5715.657060576295, 5849.590528663038, 5929.3181284152015, 6010.459058684739, 6087.05650624154, 122569.0, 124375.3781231088, 124469.0, 124799.0, 125228.37385813195, 108502.45748771206, 108633.0, 108797.0, 112190.0, 114346.0, 91453.0, 93389.53305233567, 97778.51110744543, 99591.50204248933, 99695.0, 12527.686807829512, 12776.808347874603, 12940.352982350656, 13050.738985220052, 13197.142185757895, 42731.57268427276, 43683.344749828146, 43807.34288985732, 43874.341884871115, 44124.55875441204, 75439.0, 77875.2212477868, 78075.0, 78598.21401785909, 78990.0, 18725.157367918204, 19271.807281927002, 19392.8060719391, 19433.708494372313, 19696.704549431484, 21739.0, 22222.333330000125, 22471.32586022422, 22722.0, 22760.772392275867, 17513.387031453836, 17939.820601793814, 17975.370862019765, 18525.351612693492, 20311.695324569846, 19523.0, 20102.89948550248, 20167.798322017177, 20579.58840823145, 20869.686954695997, 18814.717779233048, 18943.242270309034, 19143.0, 20057.498562536053, 20352.08415621271, 12654.810177847156, 12880.484780609046, 13037.869621303666, 13607.455701772215, 14393.496227631982, 14106.647333816327, 14238.857611423753, 15081.321340539922, 15585.454509092127, 15725.606859828138], "value": 9482.585204969077, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 106.0, 107.0, 110.0, 98.0, 107.0, 106.0, 108.0, 108.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 116.0, 120.0, 117.0, 120.0, 116.0, 119.0, 116.0, 116.0], "value": 118.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 164.0, 162.0, 166.0, 166.0, 168.0, 164.0, 169.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 73.0, 76.0, 77.0, 78.0, 74.0, 73.0, 88.0, 75.0], "value": 76.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 79.0, 80.0, 80.0, 79.0, 80.0, 79.0, 79.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 113.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0, 118.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 150.0, 151.0, 151.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 94.0, 99.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 52.0, 52.0, 53.0, 53.0, 52.0, 52.0, 53.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 38.0, 39.0, 38.0, 39.0, 39.0, 38.0, 38.0], "value": 38.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 74.0, 76.0, 74.0, 77.0, 75.0, 77.0, 76.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 121.0, 116.0, 120.0, 120.0, 112.0, 126.0, 115.0, 119.0, 121.0], "value": 120.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 176.0, 174.0, 169.0, 170.0, 181.0, 168.0, 168.0, 170.0, 170.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 64.0, 65.0, 69.0, 68.0, 65.0, 70.0, 63.0, 67.0], "value": 66.8, "unit": "score"}]}]} 16:04:25 INFO - Return code: 0 16:04:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:04:26 INFO - # TBPL SUCCESS # 16:04:26 INFO - Running post-action listener: _package_coverage_data 16:04:26 INFO - Running post-action listener: _resource_record_post_action 16:04:26 INFO - [mozharness: 2017-09-07 23:04:26.013549Z] Finished run-tests step (success) 16:04:26 INFO - Running post-run listener: _resource_record_post_run 16:04:26 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 391213056; Read time: 220; Write time: 202884 16:04:26 INFO - TinderboxPrint: CPU usage
13.1% 16:04:26 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 220 16:04:26 INFO - TinderboxPrint: I/O write bytes / time
391,213,056 / 202,884 16:04:26 INFO - TinderboxPrint: CPU idle
8,215.6 (86.9%) 16:04:26 INFO - TinderboxPrint: CPU user
1,191.8 (12.6%) 16:04:26 INFO - TinderboxPrint: Swap in / out
0 / 0 16:04:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106631168; Read time: 48; Write time: 75644 16:04:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:04:26 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284581888; Read time: 172; Write time: 127240 16:04:26 INFO - Running post-run listener: _upload_blobber_files 16:04:26 INFO - Blob upload gear active. 16:04:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:04:26 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 16:04:26 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'] 16:04:26 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 16:04:27 INFO - (blobuploader) - INFO - Open directory for files ... 16:04:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:04:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:04:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:28 INFO - (blobuploader) - INFO - Done attempting. 16:04:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:04:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:04:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:28 INFO - (blobuploader) - INFO - Done attempting. 16:04:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:04:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:04:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:32 INFO - (blobuploader) - INFO - Done attempting. 16:04:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:04:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:04:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:33 INFO - (blobuploader) - INFO - Done attempting. 16:04:33 INFO - (blobuploader) - INFO - Iteration through files over. 16:04:33 INFO - Return code: 0 16:04:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:04:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:04:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3f03b890608a635a510709fb01cd91bb2e16f9a1abbc2e2f2d4f7edcf5b9169da8f8a031cae994ff7296c258e6d81c025a63a5e271a410fa8b5be27a3829730", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ac52062304a027204afe4ec74e13c1c400c557f6cfcfd66414dea4c68dbbb352b04955a33d96d45f31ec96f23d24a46b4bde95ecdd9629857a7a3588415f2d0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5047cc74440d6bedf9b1cc800c15b0e730424a7060047c698e37ad4d7d4e6b98daf159138efc4170c62b51ac2c1f71d3ab96c6d85b64a02f8e5e214c946e44de", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdc66f91294a693e3692af8799528b5d22e534a06423ce5871d28e865c091940a76d18b0e53611f979a88f38331ab82db41e0aac76922cfb2ff39c52c0a744ce"} 16:04:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:04:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:04:33 INFO - Contents: 16:04:33 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3f03b890608a635a510709fb01cd91bb2e16f9a1abbc2e2f2d4f7edcf5b9169da8f8a031cae994ff7296c258e6d81c025a63a5e271a410fa8b5be27a3829730", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ac52062304a027204afe4ec74e13c1c400c557f6cfcfd66414dea4c68dbbb352b04955a33d96d45f31ec96f23d24a46b4bde95ecdd9629857a7a3588415f2d0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5047cc74440d6bedf9b1cc800c15b0e730424a7060047c698e37ad4d7d4e6b98daf159138efc4170c62b51ac2c1f71d3ab96c6d85b64a02f8e5e214c946e44de", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdc66f91294a693e3692af8799528b5d22e534a06423ce5871d28e865c091940a76d18b0e53611f979a88f38331ab82db41e0aac76922cfb2ff39c52c0a744ce"} 16:04:33 INFO - Running post-run listener: copy_logs_to_upload_dir 16:04:33 INFO - Copying logs to upload dir... 16:04:33 INFO - mkdir: /builds/slave/test/build/upload/logs 16:04:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.543795 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-07 16:04:33.387239) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 16:04:33.391497) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687 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/c3f03b890608a635a510709fb01cd91bb2e16f9a1abbc2e2f2d4f7edcf5b9169da8f8a031cae994ff7296c258e6d81c025a63a5e271a410fa8b5be27a3829730", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ac52062304a027204afe4ec74e13c1c400c557f6cfcfd66414dea4c68dbbb352b04955a33d96d45f31ec96f23d24a46b4bde95ecdd9629857a7a3588415f2d0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5047cc74440d6bedf9b1cc800c15b0e730424a7060047c698e37ad4d7d4e6b98daf159138efc4170c62b51ac2c1f71d3ab96c6d85b64a02f8e5e214c946e44de", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdc66f91294a693e3692af8799528b5d22e534a06423ce5871d28e865c091940a76d18b0e53611f979a88f38331ab82db41e0aac76922cfb2ff39c52c0a744ce"} build_url:https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011463 build_url: 'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3f03b890608a635a510709fb01cd91bb2e16f9a1abbc2e2f2d4f7edcf5b9169da8f8a031cae994ff7296c258e6d81c025a63a5e271a410fa8b5be27a3829730", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ac52062304a027204afe4ec74e13c1c400c557f6cfcfd66414dea4c68dbbb352b04955a33d96d45f31ec96f23d24a46b4bde95ecdd9629857a7a3588415f2d0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5047cc74440d6bedf9b1cc800c15b0e730424a7060047c698e37ad4d7d4e6b98daf159138efc4170c62b51ac2c1f71d3ab96c6d85b64a02f8e5e214c946e44de", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdc66f91294a693e3692af8799528b5d22e534a06423ce5871d28e865c091940a76d18b0e53611f979a88f38331ab82db41e0aac76922cfb2ff39c52c0a744ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 16:04:33.424832) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 16:04:33.425263) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1504824228.88387-1734371687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 16:04:33.475255) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 16:04:33.475585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 16:04:33.475942) ========= ========= Total master_lag: 0.19 =========