builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1504807102.42 results: success (0) revision: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:22.416458) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:22.416939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:22.417214) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:22.436578) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:22.437182) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 10:58:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-09-07 10:58:22 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113204 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:22.568143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:22.568452) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018048 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:22.618525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:22.619135) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3c96d611ebd67fc219d22bcb476a72412c76f6c7 --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 3c96d611ebd67fc219d22bcb476a72412c76f6c7 --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=82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 10:58:22,675 truncating revision to first 12 chars 2017-09-07 10:58:22,675 Setting DEBUG logging. 2017-09-07 10:58:22,675 attempt 1/10 2017-09-07 10:58:22,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3c96d611ebd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-07 10:58:23,031 unpacking tar archive at: mozilla-central-3c96d611ebd6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.698727 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:23.335229) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:23.335529) ========= script_repo_revision: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:23.335913) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:23.336174) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 10:58:23.348703) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-07 10:58:23.349010) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:58:23 INFO - MultiFileLogger online at 20170907 10:58:23 in /builds/slave/test 10:58:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:58:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:58:23 INFO - {'append_to_log': False, 10:58:23 INFO - 'base_work_dir': '/builds/slave/test', 10:58:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:58:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:58:23 INFO - 'branch': 'Firefox-Non-PGO', 10:58:23 INFO - 'buildbot_json_path': 'buildprops.json', 10:58:23 INFO - 'code_coverage': False, 10:58:23 INFO - 'config_files': ('talos/linux_config.py',), 10:58:23 INFO - 'default_actions': ('clobber', 10:58:23 INFO - 'read-buildbot-config', 10:58:23 INFO - 'download-and-extract', 10:58:23 INFO - 'populate-webroot', 10:58:23 INFO - 'create-virtualenv', 10:58:23 INFO - 'install', 10:58:23 INFO - 'setup-mitmproxy', 10:58:23 INFO - 'run-tests'), 10:58:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:58:23 INFO - 'disable_ccov_upload': False, 10:58:23 INFO - 'disable_stylo': False, 10:58:23 INFO - 'download_minidump_stackwalk': True, 10:58:23 INFO - 'download_symbols': 'ondemand', 10:58:23 INFO - 'enable_stylo': False, 10:58:23 INFO - 'enable_webrender': False, 10:58:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 10:58:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:58:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:58:23 INFO - 'gecko_profile': False, 10:58:23 INFO - 'gecko_profile_interval': 0, 10:58:23 INFO - 'installer_path': 'installer.exe', 10:58:23 INFO - 'log_level': 'info', 10:58:23 INFO - 'log_name': 'talos', 10:58:23 INFO - 'log_to_console': True, 10:58:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:58:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:58:23 INFO - 'opt_config_files': (), 10:58:23 INFO - 'pip_index': False, 10:58:23 INFO - 'suite': 'dromaeojs-e10s', 10:58:23 INFO - 'system_bits': '32', 10:58:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:58:23 INFO - 'title': 'talos-linux64-ix-066', 10:58:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:58:23 INFO - 'use_talos_json': True, 10:58:23 INFO - 'verify': 'False', 10:58:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:58:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:58:23 INFO - 'work_dir': 'build'} 10:58:23 INFO - [mozharness: 2017-09-07 17:58:23.548812Z] Running clobber step. 10:58:23 INFO - Running pre-action listener: _resource_record_pre_action 10:58:23 INFO - Running main action method: clobber 10:58:23 INFO - rmtree: /builds/slave/test/build 10:58:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:58:24 INFO - Running post-action listener: _resource_record_post_action 10:58:24 INFO - [mozharness: 2017-09-07 17:58:24.573478Z] Finished clobber step (success) 10:58:24 INFO - [mozharness: 2017-09-07 17:58:24.573576Z] Running read-buildbot-config step. 10:58:24 INFO - Running pre-action listener: _resource_record_pre_action 10:58:24 INFO - Running main action method: read_buildbot_config 10:58:24 INFO - Using buildbot properties: 10:58:24 INFO - { 10:58:24 INFO - "project": "", 10:58:24 INFO - "product": "firefox", 10:58:24 INFO - "who": "ffxbld@noreply.mozilla.org", 10:58:24 INFO - "installer_path": "public/build/target.tar.bz2", 10:58:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:58:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:58:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 10:58:24 INFO - "stage_platform": "linux64", 10:58:24 INFO - "basedir": "/builds/slave/test", 10:58:24 INFO - "buildnumber": 1122, 10:58:24 INFO - "platform": "ubuntu64_hw", 10:58:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:58:24 INFO - "slavebuilddir": "test", 10:58:24 INFO - "taskId": "ENvC-cp_TviKJx-k2mjEhA", 10:58:24 INFO - "branch": "mozilla-central", 10:58:24 INFO - "script_repo_revision": "production", 10:58:24 INFO - "revision": "3c96d611ebd67fc219d22bcb476a72412c76f6c7", 10:58:24 INFO - "slavename": "talos-linux64-ix-066", 10:58:24 INFO - "repo_path": "mozilla-central" 10:58:24 INFO - } 10:58:24 INFO - Finding installer, test and symbols from parent task. 10:58:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ENvC-cp_TviKJx-k2mjEhA'}, attempt #1 10:58:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ENvC-cp_TviKJx-k2mjEhA'}, attempt #1 10:58:25 INFO - Task dependencies: ErCwGB7lSTS6L7N4qpQiKw 10:58:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw'}, attempt #1 10:58:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 10:58:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json 10:58:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip 10:58:26 INFO - Running post-action listener: _resource_record_post_action 10:58:26 INFO - [mozharness: 2017-09-07 17:58:26.097361Z] Finished read-buildbot-config step (success) 10:58:26 INFO - [mozharness: 2017-09-07 17:58:26.097574Z] Running download-and-extract step. 10:58:26 INFO - Running pre-action listener: _resource_record_pre_action 10:58:26 INFO - Running main action method: download_and_extract 10:58:26 INFO - mkdir: /builds/slave/test/build/tests 10:58: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')]} 10:58:26 INFO - trying https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json 10:58:26 INFO - Downloading https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:58:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:58:26 INFO - Downloaded 989 bytes. 10:58:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:58:26 INFO - Using the following test package requirements: 10:58:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:58:26 INFO - u'common': [u'target.common.tests.zip'], 10:58:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:58:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:58:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:58:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:58:26 INFO - u'mozbase': [u'target.common.tests.zip'], 10:58:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:58:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:58:26 INFO - u'web-platform': [u'target.common.tests.zip', 10:58:26 INFO - u'target.web-platform.tests.tar.gz'], 10:58:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:58:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:58:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip 10:58:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:58:26 INFO - Fetch https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip into memory 10:58:27 INFO - Content-Length response header: 55021210 10:58:27 INFO - Bytes received: 55021210 10:58:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:58:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip 10:58:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:58:38 INFO - Fetch https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.common.tests.zip into memory 10:58:39 INFO - Content-Length response header: 55021210 10:58:39 INFO - Bytes received: 55021210 10:58:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.talos.tests.zip 10:58:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:58:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.talos.tests.zip into memory 10:58:52 INFO - Content-Length response header: 14496665 10:58:52 INFO - Bytes received: 14496665 10:58: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')]} 10:58:52 INFO - trying https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 10:58:52 INFO - Downloading https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:58:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:58:54 INFO - Downloaded 62754681 bytes. 10:58:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 10:58:54 INFO - mkdir: /builds/slave/test/properties 10:58:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:58:54 INFO - Writing to file /builds/slave/test/properties/build_url 10:58:54 INFO - Contents: 10:58:54 INFO - build_url:https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 10:58:54 INFO - Running post-action listener: _resource_record_post_action 10:58:54 INFO - Running post-action listener: find_tests_for_verification 10:58:54 INFO - Running post-action listener: set_extra_try_arguments 10:58:54 INFO - [mozharness: 2017-09-07 17:58:54.037213Z] Finished download-and-extract step (success) 10:58:54 INFO - [mozharness: 2017-09-07 17:58:54.037328Z] Running populate-webroot step. 10:58:54 INFO - Running pre-action listener: _resource_record_pre_action 10:58:54 INFO - Running main action method: populate_webroot 10:58:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:58:54 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:54 INFO - 'tests': ['tresize', 10:58:54 INFO - 'tcanvasmark']}, 10:58:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:58:54 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:54 INFO - 'tests': ['dromaeo_css', 10:58:54 INFO - 'kraken']}, 10:58:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:58:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:58:54 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:58:54 INFO - 'talos_options': ['--disable-stylo'], 10:58:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:58:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:58:54 INFO - 'tests': ['damp', 'tps']}, 10:58:54 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:58:54 INFO - 'talos_options': ['--disable-stylo'], 10:58:54 INFO - 'tests': ['damp', 'tps']}, 10:58:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:58:54 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:54 INFO - 'tests': ['dromaeo_dom']}, 10:58:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:58:54 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:54 INFO - 'tests': ['basic_compositor_video', 10:58:54 INFO - 'glvideo']}, 10:58:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:58:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:58:54 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:58:54 INFO - 'talos_options': ['--disable-stylo'], 10:58:54 INFO - 'tests': ['ts_paint_webext', 10:58:54 INFO - 'tp5o_webext']}, 10:58:54 INFO - 'other-e10s': {'tests': ['a11yr', 10:58:54 INFO - 'ts_paint', 10:58:54 INFO - 'tpaint', 10:58:54 INFO - 'sessionrestore', 10:58:54 INFO - 'sessionrestore_many_windows', 10:58:54 INFO - 'sessionrestore_no_auto_restore', 10:58:54 INFO - 'tabpaint']}, 10:58:54 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:54 INFO - 'tests': ['a11yr', 10:58:54 INFO - 'ts_paint', 10:58:54 INFO - 'tpaint', 10:58:54 INFO - 'sessionrestore', 10:58:54 INFO - 'sessionrestore_many_windows', 10:58:54 INFO - 'sessionrestore_no_auto_restore', 10:58:54 INFO - 'tabpaint']}, 10:58:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:58:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:58:54 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:54 INFO - 'tests': ['bloom_basic_singleton']}, 10:58:54 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:54 INFO - 'tests': ['bloom_basic']}, 10:58:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:58:54 INFO - 'tsvgr_opacity', 10:58:54 INFO - 'tart', 10:58:54 INFO - 'tscrollx', 10:58:54 INFO - 'tsvg_static']}, 10:58:54 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:58:54 INFO - 'tests': ['tsvgx', 10:58:54 INFO - 'tsvgr_opacity', 10:58:54 INFO - 'tart', 10:58:54 INFO - 'tscrollx', 10:58:54 INFO - 'tsvg_static']}, 10:58:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:58:54 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:58:54 INFO - 'talos_options': ['--disable-stylo'], 10:58:54 INFO - 'tests': ['tp5o']}, 10:58:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:58:54 INFO - 'talos_options': ['--mitmproxy', 10:58:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:58:54 INFO - '--firstNonBlankPaint'], 10:58:54 INFO - 'tests': ['tp6_google', 10:58:54 INFO - 'tp6_youtube', 10:58:54 INFO - 'tp6_amazon', 10:58:54 INFO - 'tp6_facebook']}, 10:58:54 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:58:54 INFO - 'talos_options': ['--disable-stylo', 10:58:54 INFO - '--mitmproxy', 10:58:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:58:54 INFO - '--firstNonBlankPaint'], 10:58:54 INFO - 'tests': ['tp6_google', 10:58:54 INFO - 'tp6_youtube', 10:58:54 INFO - 'tp6_amazon', 10:58:54 INFO - 'tp6_facebook']}, 10:58:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:58:54 INFO - 'talos_options': ['--stylo-threads=1', 10:58:54 INFO - '--mitmproxy', 10:58:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:58:54 INFO - '--firstNonBlankPaint'], 10:58:54 INFO - 'tests': ['tp6_google', 10:58:54 INFO - 'tp6_youtube', 10:58:54 INFO - 'tp6_amazon', 10:58:54 INFO - 'tp6_facebook']}, 10:58:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:58:54 INFO - 'talos_options': ['--xperf_path', 10:58:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:58:54 INFO - 'tests': ['tp5n']}, 10:58:54 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:58:54 INFO - 'talos_options': ['--disable-stylo', 10:58:54 INFO - '--xperf_path', 10:58:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:58:54 INFO - 'tests': ['tp5n']}}} 10:58:54 INFO - Running post-action listener: _resource_record_post_action 10:58:54 INFO - [mozharness: 2017-09-07 17:58:54.055896Z] Finished populate-webroot step (success) 10:58:54 INFO - [mozharness: 2017-09-07 17:58:54.056001Z] Running create-virtualenv step. 10:58:54 INFO - Running pre-action listener: _resource_record_pre_action 10:58:54 INFO - Running main action method: create_virtualenv 10:58:54 INFO - Creating virtualenv /builds/slave/test/build/venv 10:58:54 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:58:54 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 10:58:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:58:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:58:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:58:54 INFO - Installing distribute.............................................................................................................................................................................................done. 10:58:54 INFO - Installing pip...............done. 10:58:54 INFO - Return code: 0 10:58:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:58:55 INFO - Reading from file tmpfile_stdout 10:58:55 INFO - Output received: 10:58:55 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 10:58:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x161a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1986a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a090>, '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 0x198ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', '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 10:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:58:55 INFO - Using env: {'DISPLAY': ':0', 10:58:55 INFO - 'HOME': '/home/cltbld', 10:58:55 INFO - 'LANG': 'en_US.UTF-8', 10:58:55 INFO - 'LANGUAGE': 'en_US:en', 10:58:55 INFO - 'LOGNAME': 'cltbld', 10:58:55 INFO - 'MAIL': '/var/mail/cltbld', 10:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:55 INFO - 'MOZ_NO_REMOTE': '1', 10:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:55 INFO - 'NO_EM_RESTART': '1', 10:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:55 INFO - 'PWD': '/builds/slave/test', 10:58:55 INFO - 'SHELL': '/bin/bash', 10:58:55 INFO - 'SHLVL': '1', 10:58:55 INFO - 'TERM': 'linux', 10:58:55 INFO - 'TMOUT': '86400', 10:58:55 INFO - 'USER': 'cltbld', 10:58:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 10:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:55 INFO - '_': '/tools/buildbot/bin/python'} 10:58:56 INFO - Ignoring indexes: http://pypi.python.org/simple/ 10:58:56 INFO - Downloading/unpacking pip>=1.5 10:58:56 INFO - Running setup.py egg_info for package pip 10:58:56 INFO - warning: no files found matching 'pip/cacert.pem' 10:58:56 INFO - warning: no files found matching '*.html' under directory 'docs' 10:58:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:58:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:58:56 INFO - Installing collected packages: pip 10:58:56 INFO - Found existing installation: pip 1.1 10:58:56 INFO - Uninstalling pip: 10:58:56 INFO - Successfully uninstalled pip 10:58:56 INFO - Running setup.py install for pip 10:58:56 INFO - warning: no files found matching 'pip/cacert.pem' 10:58:56 INFO - warning: no files found matching '*.html' under directory 'docs' 10:58:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:58:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:58:56 INFO - Installing pip script to /builds/slave/test/build/venv/bin 10:58:56 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 10:58:56 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 10:58:56 INFO - Successfully installed pip 10:58:56 INFO - Cleaning up... 10:58:56 INFO - Return code: 0 10:58:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:58: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')]} 10:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58: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')]} 10:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x161a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1986a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a090>, '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 0x198ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', '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 10:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:58:56 INFO - Using env: {'DISPLAY': ':0', 10:58:56 INFO - 'HOME': '/home/cltbld', 10:58:56 INFO - 'LANG': 'en_US.UTF-8', 10:58:56 INFO - 'LANGUAGE': 'en_US:en', 10:58:56 INFO - 'LOGNAME': 'cltbld', 10:58:56 INFO - 'MAIL': '/var/mail/cltbld', 10:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:56 INFO - 'MOZ_NO_REMOTE': '1', 10:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:56 INFO - 'NO_EM_RESTART': '1', 10:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:56 INFO - 'PWD': '/builds/slave/test', 10:58:56 INFO - 'SHELL': '/bin/bash', 10:58:56 INFO - 'SHLVL': '1', 10:58:56 INFO - 'TERM': 'linux', 10:58:56 INFO - 'TMOUT': '86400', 10:58:56 INFO - 'USER': 'cltbld', 10:58:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 10:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:56 INFO - '_': '/tools/buildbot/bin/python'} 10:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:56 INFO - Downloading/unpacking psutil>=3.1.1 10:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:58:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:58:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:58:57 INFO - Installing collected packages: psutil 10:58:57 INFO - Running setup.py install for psutil 10:58:57 INFO - building 'psutil._psutil_linux' extension 10:58:57 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 10:58:57 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 10:58:57 INFO - building 'psutil._psutil_posix' extension 10:58:57 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 10:58:58 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 10:58:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:58:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:58:58 INFO - Successfully installed psutil 10:58:58 INFO - Cleaning up... 10:58:58 INFO - Return code: 0 10:58:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:58:58 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')]} 10:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:58 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')]} 10:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:58 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 0x161a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1986a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a090>, '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 0x198ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', '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 10:58:58 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 10:58:58 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 10:58:58 INFO - Using env: {'DISPLAY': ':0', 10:58:58 INFO - 'HOME': '/home/cltbld', 10:58:58 INFO - 'LANG': 'en_US.UTF-8', 10:58:58 INFO - 'LANGUAGE': 'en_US:en', 10:58:58 INFO - 'LOGNAME': 'cltbld', 10:58:58 INFO - 'MAIL': '/var/mail/cltbld', 10:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:58 INFO - 'MOZ_NO_REMOTE': '1', 10:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:58 INFO - 'NO_EM_RESTART': '1', 10:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:58 INFO - 'PWD': '/builds/slave/test', 10:58:58 INFO - 'SHELL': '/bin/bash', 10:58:58 INFO - 'SHLVL': '1', 10:58:58 INFO - 'TERM': 'linux', 10:58:58 INFO - 'TMOUT': '86400', 10:58:58 INFO - 'USER': 'cltbld', 10:58:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 10:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:58 INFO - '_': '/tools/buildbot/bin/python'} 10:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:58:59 INFO - Installing collected packages: mozsystemmonitor 10:58:59 INFO - Running setup.py install for mozsystemmonitor 10:58:59 INFO - Successfully installed mozsystemmonitor 10:58:59 INFO - Cleaning up... 10:58:59 INFO - Return code: 0 10:58:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x161a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1986a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a090>, '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 0x198ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', '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 10:58:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:58:59 INFO - Using env: {'DISPLAY': ':0', 10:58:59 INFO - 'HOME': '/home/cltbld', 10:58:59 INFO - 'LANG': 'en_US.UTF-8', 10:58:59 INFO - 'LANGUAGE': 'en_US:en', 10:58:59 INFO - 'LOGNAME': 'cltbld', 10:58:59 INFO - 'MAIL': '/var/mail/cltbld', 10:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:59 INFO - 'MOZ_NO_REMOTE': '1', 10:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:59 INFO - 'NO_EM_RESTART': '1', 10:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:59 INFO - 'PWD': '/builds/slave/test', 10:58:59 INFO - 'SHELL': '/bin/bash', 10:58:59 INFO - 'SHLVL': '1', 10:58:59 INFO - 'TERM': 'linux', 10:58:59 INFO - 'TMOUT': '86400', 10:58:59 INFO - 'USER': 'cltbld', 10:58:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 10:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:59 INFO - '_': '/tools/buildbot/bin/python'} 10:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:59 INFO - Downloading/unpacking jsonschema==2.5.1 10:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:59:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:59:01 INFO - warning: no files found matching '*.txt' 10:59:01 INFO - no previously-included directories found matching 'build' 10:59:01 INFO - no previously-included directories found matching 'dist' 10:59:01 INFO - no previously-included directories found matching '.git*' 10:59:01 INFO - Installing collected packages: jsonschema, functools32 10:59:01 INFO - Running setup.py install for functools32 10:59:01 INFO - warning: no files found matching '*.txt' 10:59:01 INFO - no previously-included directories found matching 'build' 10:59:01 INFO - no previously-included directories found matching 'dist' 10:59:01 INFO - no previously-included directories found matching '.git*' 10:59:01 INFO - Successfully installed jsonschema functools32 10:59:01 INFO - Cleaning up... 10:59:01 INFO - Return code: 0 10:59:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:59:01 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')]} 10:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:01 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')]} 10:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:01 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 0x161a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1986a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a090>, '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 0x198ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', '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 10:59:01 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 10:59:01 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 10:59:01 INFO - Using env: {'DISPLAY': ':0', 10:59:01 INFO - 'HOME': '/home/cltbld', 10:59:01 INFO - 'LANG': 'en_US.UTF-8', 10:59:01 INFO - 'LANGUAGE': 'en_US:en', 10:59:01 INFO - 'LOGNAME': 'cltbld', 10:59:01 INFO - 'MAIL': '/var/mail/cltbld', 10:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:01 INFO - 'MOZ_NO_REMOTE': '1', 10:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:01 INFO - 'NO_EM_RESTART': '1', 10:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:01 INFO - 'PWD': '/builds/slave/test', 10:59:01 INFO - 'SHELL': '/bin/bash', 10:59:01 INFO - 'SHLVL': '1', 10:59:01 INFO - 'TERM': 'linux', 10:59:01 INFO - 'TMOUT': '86400', 10:59:01 INFO - 'USER': 'cltbld', 10:59:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 10:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:01 INFO - '_': '/tools/buildbot/bin/python'} 10:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:59:01 INFO - Cleaning up... 10:59:01 INFO - Return code: 0 10:59:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:59:01 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')]} 10:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:01 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')]} 10:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:01 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 0x161a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1986a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a090>, '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 0x198ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', '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 10:59:01 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 10:59:01 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 10:59:01 INFO - Using env: {'DISPLAY': ':0', 10:59:01 INFO - 'HOME': '/home/cltbld', 10:59:01 INFO - 'LANG': 'en_US.UTF-8', 10:59:01 INFO - 'LANGUAGE': 'en_US:en', 10:59:01 INFO - 'LOGNAME': 'cltbld', 10:59:01 INFO - 'MAIL': '/var/mail/cltbld', 10:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:01 INFO - 'MOZ_NO_REMOTE': '1', 10:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:01 INFO - 'NO_EM_RESTART': '1', 10:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:01 INFO - 'PWD': '/builds/slave/test', 10:59:01 INFO - 'SHELL': '/bin/bash', 10:59:01 INFO - 'SHLVL': '1', 10:59:01 INFO - 'TERM': 'linux', 10:59:01 INFO - 'TMOUT': '86400', 10:59:01 INFO - 'USER': 'cltbld', 10:59:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 10:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:01 INFO - '_': '/tools/buildbot/bin/python'} 10:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:01 INFO - Downloading/unpacking blobuploader==1.2.4 10:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:02 INFO - Downloading blobuploader-1.2.4.tar.gz 10:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:59:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:59:03 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 10:59:03 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 10:59:03 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 10:59:03 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 10:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:59:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:59:03 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 10:59:03 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 10:59:03 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 10:59:03 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 10:59:03 INFO - Downloading docopt-0.6.1.tar.gz 10:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:59:03 INFO - Installing collected packages: blobuploader, requests, docopt 10:59:03 INFO - Running setup.py install for blobuploader 10:59:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:59:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:59:03 INFO - Running setup.py install for requests 10:59:04 INFO - Running setup.py install for docopt 10:59:04 INFO - Successfully installed blobuploader requests docopt 10:59:04 INFO - Cleaning up... 10:59:04 INFO - Return code: 0 10:59:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:04 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')]} 10:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:04 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')]} 10:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:04 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 0x161a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1986a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a090>, '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 0x198ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', '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 10:59:04 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 10:59:04 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 10:59:04 INFO - Using env: {'DISPLAY': ':0', 10:59:04 INFO - 'HOME': '/home/cltbld', 10:59:04 INFO - 'LANG': 'en_US.UTF-8', 10:59:04 INFO - 'LANGUAGE': 'en_US:en', 10:59:04 INFO - 'LOGNAME': 'cltbld', 10:59:04 INFO - 'MAIL': '/var/mail/cltbld', 10:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:04 INFO - 'MOZ_NO_REMOTE': '1', 10:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:04 INFO - 'NO_EM_RESTART': '1', 10:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:04 INFO - 'PWD': '/builds/slave/test', 10:59:04 INFO - 'SHELL': '/bin/bash', 10:59:04 INFO - 'SHLVL': '1', 10:59:04 INFO - 'TERM': 'linux', 10:59:04 INFO - 'TMOUT': '86400', 10:59:04 INFO - 'USER': 'cltbld', 10:59:04 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 10:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:04 INFO - '_': '/tools/buildbot/bin/python'} 10:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:04 INFO - Running setup.py (path:/tmp/pip-tueayC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:04 INFO - Running setup.py (path:/tmp/pip-LaG0ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:04 INFO - Running setup.py (path:/tmp/pip-ak2Xn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:04 INFO - Running setup.py (path:/tmp/pip-eCYSvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:04 INFO - Running setup.py (path:/tmp/pip-56WrT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:04 INFO - Running setup.py (path:/tmp/pip-N7Kky9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:04 INFO - Running setup.py (path:/tmp/pip-ZBYEs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:04 INFO - Running setup.py (path:/tmp/pip-Q7_ISd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:04 INFO - Running setup.py (path:/tmp/pip-alp_d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:05 INFO - Running setup.py (path:/tmp/pip-7Am4DQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:05 INFO - Running setup.py (path:/tmp/pip-EtY8Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:05 INFO - Running setup.py (path:/tmp/pip-90SHu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:05 INFO - Running setup.py (path:/tmp/pip-lr7V6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:05 INFO - Running setup.py (path:/tmp/pip-0xCgR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:05 INFO - Running setup.py (path:/tmp/pip-2aUtjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:05 INFO - Running setup.py (path:/tmp/pip-M5eXkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:05 INFO - Running setup.py (path:/tmp/pip-zJILDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:59:05 INFO - Running setup.py install for manifestparser 10:59:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:59:05 INFO - Running setup.py install for mozcrash 10:59:05 INFO - Running setup.py install for mozdebug 10:59:05 INFO - Running setup.py install for mozdevice 10:59:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:59:05 INFO - Running setup.py install for mozfile 10:59:06 INFO - Running setup.py install for mozhttpd 10:59:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:59:06 INFO - Running setup.py install for mozinfo 10:59:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:59:06 INFO - Running setup.py install for mozInstall 10:59:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:59:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:59:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:59:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:59:06 INFO - Running setup.py install for mozleak 10:59:06 INFO - Running setup.py install for mozlog 10:59:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:59:06 INFO - Running setup.py install for moznetwork 10:59:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:59:06 INFO - Running setup.py install for mozprocess 10:59:06 INFO - Running setup.py install for mozprofile 10:59:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:59:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:59:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:59:06 INFO - Running setup.py install for mozrunner 10:59:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:59:07 INFO - Running setup.py install for mozscreenshot 10:59:07 INFO - Running setup.py install for moztest 10:59:07 INFO - Running setup.py install for mozversion 10:59:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:59:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:59:07 INFO - Cleaning up... 10:59:07 INFO - Return code: 0 10:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:07 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')]} 10:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:07 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')]} 10:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:07 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 0x161a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1986a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a090>, '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 0x198ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', '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 10:59:07 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 10:59:07 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 10:59:07 INFO - Using env: {'DISPLAY': ':0', 10:59:07 INFO - 'HOME': '/home/cltbld', 10:59:07 INFO - 'LANG': 'en_US.UTF-8', 10:59:07 INFO - 'LANGUAGE': 'en_US:en', 10:59:07 INFO - 'LOGNAME': 'cltbld', 10:59:07 INFO - 'MAIL': '/var/mail/cltbld', 10:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:07 INFO - 'MOZ_NO_REMOTE': '1', 10:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:07 INFO - 'NO_EM_RESTART': '1', 10:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:07 INFO - 'PWD': '/builds/slave/test', 10:59:07 INFO - 'SHELL': '/bin/bash', 10:59:07 INFO - 'SHLVL': '1', 10:59:07 INFO - 'TERM': 'linux', 10:59:07 INFO - 'TMOUT': '86400', 10:59:07 INFO - 'USER': 'cltbld', 10:59:07 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 10:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:07 INFO - '_': '/tools/buildbot/bin/python'} 10:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:07 INFO - Running setup.py (path:/tmp/pip-DTPZ48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:07 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)) 10:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:07 INFO - Running setup.py (path:/tmp/pip-s81Ogz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:07 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)) 10:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:07 INFO - Running setup.py (path:/tmp/pip-J90Sd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:07 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)) 10:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:07 INFO - Running setup.py (path:/tmp/pip-5CDu1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:07 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)) 10:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:07 INFO - Running setup.py (path:/tmp/pip-YZZhIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:07 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)) 10:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:07 INFO - Running setup.py (path:/tmp/pip-oyYpP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:07 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)) 10:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:07 INFO - Running setup.py (path:/tmp/pip-mgYBeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:08 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)) 10:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:08 INFO - Running setup.py (path:/tmp/pip-hlSSjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:08 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)) 10:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:08 INFO - Running setup.py (path:/tmp/pip-0i91Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:08 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)) 10:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:08 INFO - Running setup.py (path:/tmp/pip-aLS6C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:08 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)) 10:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:08 INFO - Running setup.py (path:/tmp/pip-k00l1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:08 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)) 10:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:08 INFO - Running setup.py (path:/tmp/pip-ghKRV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:08 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)) 10:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:08 INFO - Running setup.py (path:/tmp/pip-wgNYIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:08 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)) 10:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:08 INFO - Running setup.py (path:/tmp/pip-fOlmuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:08 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)) 10:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:08 INFO - Running setup.py (path:/tmp/pip-uL31yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:08 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)) 10:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:08 INFO - Running setup.py (path:/tmp/pip-ur2F9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:08 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)) 10:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:08 INFO - Running setup.py (path:/tmp/pip-oJzEJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:08 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)) 10:59:08 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)) 10:59:08 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)) 10:59:08 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)) 10:59:08 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)) 10:59:08 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)) 10:59:08 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)) 10:59:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:09 INFO - Downloading blessings-1.6.tar.gz 10:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:59:09 INFO - Installing collected packages: blessings 10:59:09 INFO - Running setup.py install for blessings 10:59:10 INFO - Successfully installed blessings 10:59:10 INFO - Cleaning up... 10:59:10 INFO - Return code: 0 10:59:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:59:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:10 INFO - Reading from file tmpfile_stdout 10:59:10 INFO - Current package versions: 10:59:10 INFO - argparse == 1.2.1 10:59:10 INFO - blessings == 1.6 10:59:10 INFO - blobuploader == 1.2.4 10:59:10 INFO - docopt == 0.6.1 10:59:10 INFO - functools32 == 3.2.3-2 10:59:10 INFO - jsonschema == 2.5.1 10:59:10 INFO - manifestparser == 1.1 10:59:10 INFO - mozInstall == 1.13 10:59:10 INFO - mozcrash == 1.0 10:59:10 INFO - mozdebug == 0.1 10:59:10 INFO - mozdevice == 0.51 10:59:10 INFO - mozfile == 1.2 10:59:10 INFO - mozhttpd == 0.7 10:59:10 INFO - mozinfo == 0.10 10:59:10 INFO - mozleak == 0.1 10:59:10 INFO - mozlog == 3.5 10:59:10 INFO - moznetwork == 0.27 10:59:10 INFO - mozprocess == 0.25 10:59:10 INFO - mozprofile == 0.28 10:59:10 INFO - mozrunner == 6.13 10:59:10 INFO - mozscreenshot == 0.1 10:59:10 INFO - mozsystemmonitor == 0.3 10:59:10 INFO - moztest == 0.8 10:59:10 INFO - mozversion == 1.4 10:59:10 INFO - psutil == 3.1.1 10:59:10 INFO - requests == 1.2.3 10:59:10 INFO - wsgiref == 0.1.2 10:59:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:10 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 0x161a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1986a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a090>, '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 0x198ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', '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 10:59:10 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 10:59:10 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 10:59:10 INFO - Using env: {'DISPLAY': ':0', 10:59:10 INFO - 'HOME': '/home/cltbld', 10:59:10 INFO - 'LANG': 'en_US.UTF-8', 10:59:10 INFO - 'LANGUAGE': 'en_US:en', 10:59:10 INFO - 'LOGNAME': 'cltbld', 10:59:10 INFO - 'MAIL': '/var/mail/cltbld', 10:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:10 INFO - 'MOZ_NO_REMOTE': '1', 10:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:10 INFO - 'NO_EM_RESTART': '1', 10:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:10 INFO - 'PWD': '/builds/slave/test', 10:59:10 INFO - 'SHELL': '/bin/bash', 10:59:10 INFO - 'SHLVL': '1', 10:59:10 INFO - 'TERM': 'linux', 10:59:10 INFO - 'TMOUT': '86400', 10:59:10 INFO - 'USER': 'cltbld', 10:59:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 10:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:10 INFO - '_': '/tools/buildbot/bin/python'} 10:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:10 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)) 10:59:10 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)) 10:59:10 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)) 10:59:10 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)) 10:59:10 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)) 10:59:10 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)) 10:59:10 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)) 10:59:10 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)) 10:59:10 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)) 10:59:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 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 10:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:59:11 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)) 10:59:11 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)) 10:59:11 INFO - Installing collected packages: simplejson 10:59:11 INFO - Running setup.py install for simplejson 10:59:11 INFO - building 'simplejson._speedups' extension 10:59:11 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 10:59:12 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 10:59:12 INFO - Successfully installed simplejson 10:59:12 INFO - Cleaning up... 10:59:12 INFO - Return code: 0 10:59:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:59:12 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')]} 10:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:12 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')]} 10:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:12 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 0x161a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1986a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198a090>, '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 0x198ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984f90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', '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 10:59:12 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 10:59:12 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 10:59:12 INFO - Using env: {'DISPLAY': ':0', 10:59:12 INFO - 'HOME': '/home/cltbld', 10:59:12 INFO - 'LANG': 'en_US.UTF-8', 10:59:12 INFO - 'LANGUAGE': 'en_US:en', 10:59:12 INFO - 'LOGNAME': 'cltbld', 10:59:12 INFO - 'MAIL': '/var/mail/cltbld', 10:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:12 INFO - 'MOZ_NO_REMOTE': '1', 10:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:12 INFO - 'NO_EM_RESTART': '1', 10:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:12 INFO - 'PWD': '/builds/slave/test', 10:59:12 INFO - 'SHELL': '/bin/bash', 10:59:12 INFO - 'SHLVL': '1', 10:59:12 INFO - 'TERM': 'linux', 10:59:12 INFO - 'TMOUT': '86400', 10:59:12 INFO - 'USER': 'cltbld', 10:59:12 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 10:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:12 INFO - '_': '/tools/buildbot/bin/python'} 10:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:59:12 INFO - Cleaning up... 10:59:12 INFO - Return code: 0 10:59:12 INFO - Running post-action listener: _resource_record_post_action 10:59:12 INFO - Running post-action listener: _start_resource_monitoring 10:59:13 INFO - Starting resource monitoring. 10:59:13 INFO - [mozharness: 2017-09-07 17:59:13.004226Z] Finished create-virtualenv step (success) 10:59:13 INFO - [mozharness: 2017-09-07 17:59:13.004735Z] Running install step. 10:59:13 INFO - Running pre-action listener: _resource_record_pre_action 10:59:13 INFO - Running main action method: install 10:59:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:13 INFO - Reading from file tmpfile_stdout 10:59:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:59:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:59:13 INFO - Reading from file tmpfile_stdout 10:59:13 INFO - Output received: 10:59:13 INFO - Usage: mozinstall [options] installer 10:59:13 INFO - Options: 10:59:13 INFO - -h, --help show this help message and exit 10:59:13 INFO - -d DEST, --destination=DEST 10:59:13 INFO - Directory to install application into. [default: 10:59:13 INFO - "/builds/slave/test"] 10:59:13 INFO - --app=APP Application being installed. [default: firefox] 10:59:13 INFO - mkdir: /builds/slave/test/build/application 10:59:13 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'] 10:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:59:29 INFO - Reading from file tmpfile_stdout 10:59:29 INFO - Output received: 10:59:29 INFO - /builds/slave/test/build/application/firefox/firefox 10:59:29 INFO - Running post-action listener: _resource_record_post_action 10:59:29 INFO - [mozharness: 2017-09-07 17:59:29.866134Z] Finished install step (success) 10:59:29 INFO - [mozharness: 2017-09-07 17:59:29.866380Z] Running setup-mitmproxy step. 10:59:29 INFO - Running pre-action listener: _resource_record_pre_action 10:59:29 INFO - Running main action method: setup_mitmproxy 10:59:29 INFO - Skipping: mitmproxy is not required 10:59:29 INFO - Running post-action listener: _resource_record_post_action 10:59:29 INFO - [mozharness: 2017-09-07 17:59:29.867501Z] Finished setup-mitmproxy step (success) 10:59:29 INFO - [mozharness: 2017-09-07 17:59:29.867716Z] Running run-tests step. 10:59:29 INFO - Running pre-action listener: _resource_record_pre_action 10:59:29 INFO - Running pre-action listener: _set_gcov_prefix 10:59:29 INFO - Running main action method: run_tests 10:59:29 WARNING - Try message not found. 10:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:59:29 INFO - Python 2.7.3 10:59:29 INFO - Return code: 0 10:59:29 INFO - grabbing minidump binary from tooltool 10:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:29 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 0x198a090>, '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 0x198ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1984f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:59:29 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 10:59:29 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 10:59:29 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 10:59:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:59:29 INFO - Return code: 0 10:59:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:59:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:59:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:59:29 INFO - ENV: RUST_BACKTRACE is now full 10:59:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:59:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 10:59:30 INFO - Using env: {'DISPLAY': ':0', 10:59:30 INFO - 'HOME': '/home/cltbld', 10:59:30 INFO - 'LANG': 'en_US.UTF-8', 10:59:30 INFO - 'LANGUAGE': 'en_US:en', 10:59:30 INFO - 'LOGNAME': 'cltbld', 10:59:30 INFO - 'MAIL': '/var/mail/cltbld', 10:59:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:59:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:30 INFO - 'MOZ_NO_REMOTE': '1', 10:59:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:30 INFO - 'NO_EM_RESTART': '1', 10:59:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:30 INFO - 'PWD': '/builds/slave/test', 10:59:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:59:30 INFO - 'RUST_BACKTRACE': 'full', 10:59:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:59:30 INFO - 'SHELL': '/bin/bash', 10:59:30 INFO - 'SHLVL': '1', 10:59:30 INFO - 'TERM': 'linux', 10:59:30 INFO - 'TMOUT': '86400', 10:59:30 INFO - 'USER': 'cltbld', 10:59:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 10:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:30 INFO - '_': '/tools/buildbot/bin/python'} 10:59:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:59:30 INFO - mozversion application_buildid: 20170907171306 10:59:30 INFO - mozversion application_changeset: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 10:59:30 INFO - mozversion application_display_name: Nightly 10:59:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:59:30 INFO - mozversion application_name: Firefox 10:59:30 INFO - mozversion application_remotingname: firefox 10:59:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:59:30 INFO - mozversion application_vendor: Mozilla 10:59:30 INFO - mozversion application_version: 57.0a1 10:59:30 INFO - mozversion platform_buildid: 20170907171306 10:59:30 INFO - mozversion platform_changeset: 3c96d611ebd67fc219d22bcb476a72412c76f6c7 10:59:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:59:30 INFO - mozversion platform_version: 57.0a1 10:59:30 INFO - using testdate: 1504807170 10:59:30 INFO - actual date: 1504807170 10:59:30 INFO - starting webserver on 'localhost:58788' 10:59:30 INFO - SUITE-START | Running 2 tests 10:59:30 INFO - TEST-START | dromaeo_css 10:59:30 INFO - Initialising browser for dromaeo_css test... 10:59:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58788/getInfo.html -profile /tmp/tmp2Hrlb_/profile 10:59:30 INFO - TEST-INFO | started process 32718 (/builds/slave/test/build/application/firefox/firefox http://localhost:58788/getInfo.html) 10:59:36 INFO - TEST-INFO | 32718: exit 0 10:59:36 INFO - Browser initialized. 10:59:36 INFO - Running cycle 1/1 for dromaeo_css test... 10:59:36 INFO - Using env: {'DISPLAY': ':0', 10:59:36 INFO - 'HOME': '/home/cltbld', 10:59:36 INFO - 'JSGC_DISABLE_POISONING': '1', 10:59:36 INFO - 'LANG': 'en_US.UTF-8', 10:59:36 INFO - 'LANGUAGE': 'en_US:en', 10:59:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:59:36 INFO - 'LOGNAME': 'cltbld', 10:59:36 INFO - 'MAIL': '/var/mail/cltbld', 10:59:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:59:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:59:36 INFO - 'MOZ_CRASHREPORTER': '1', 10:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:59:36 INFO - 'MOZ_NO_REMOTE': '1', 10:59:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:36 INFO - 'NO_EM_RESTART': '1', 10:59:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:36 INFO - 'PWD': '/builds/slave/test', 10:59:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:59:36 INFO - 'RUST_BACKTRACE': 'full', 10:59:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:59:36 INFO - 'SHELL': '/bin/bash', 10:59:36 INFO - 'SHLVL': '1', 10:59:36 INFO - 'TERM': 'linux', 10:59:36 INFO - 'TMOUT': '86400', 10:59:36 INFO - 'USER': 'cltbld', 10:59:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 10:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:36 INFO - '_': '/tools/buildbot/bin/python'} 10:59:36 INFO - TEST-INFO | started process 451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Hrlb_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:59:37 INFO - PID 451 | 10:59:37 INFO - PID 451 | (/builds/slave/test/build/application/firefox/firefox:503): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:59:37 INFO - PID 451 | 10:59:47 INFO - PID 451 | RSS: Main: 170209280 10:59:47 INFO - PID 451 | 11:02:45 INFO - PID 451 | Cycle 1(1): loaded http://localhost:58788/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58788/tests/dromaeo/cssquery-ext.html) 11:02:46 INFO - PID 451 | RSS: Main: 173756416 11:02:46 INFO - PID 451 | 11:05:48 INFO - PID 451 | Cycle 1(1): loaded http://localhost:58788/tests/dromaeo/cssquery-ext.html (next: http://localhost:58788/tests/dromaeo/cssquery-jquery.html) 11:05:49 INFO - PID 451 | RSS: Main: 170246144 11:05:49 INFO - PID 451 | 11:08:50 INFO - PID 451 | Cycle 1(1): loaded http://localhost:58788/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58788/tests/dromaeo/cssquery-mootools.html) 11:08:51 INFO - PID 451 | RSS: Main: 171397120 11:08:51 INFO - PID 451 | 11:11:53 INFO - PID 451 | Cycle 1(1): loaded http://localhost:58788/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58788/tests/dromaeo/cssquery-prototype.html) 11:11:53 INFO - PID 451 | RSS: Main: 170995712 11:11:53 INFO - PID 451 | 11:14:57 INFO - PID 451 | Cycle 1(1): loaded http://localhost:58788/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58788/tests/dromaeo/cssquery-yui.html) 11:14:57 INFO - PID 451 | RSS: Main: 172064768 11:14:57 INFO - PID 451 | 11:17:59 INFO - PID 451 | Cycle 1(1): loaded http://localhost:58788/tests/dromaeo/cssquery-yui.html (next: http://localhost:58788/tests/dromaeo/cssquery-dojo.html) 11:17:59 INFO - PID 451 | RSS: Main: 174669824 11:17:59 INFO - PID 451 | 11:17:59 INFO - PID 451 | __start_tp_report 11:17:59 INFO - PID 451 | _x_x_mozilla_page_load 11:17:59 INFO - PID 451 | _x_x_mozilla_page_load_details 11:17:59 INFO - PID 451 | |i|pagename|runs| 11:17:59 INFO - PID 451 | |0;dojo.html;3287.6876696713816;3289.3256882339124;3305.520699498573;3309.5035744638303;3310.6689331066896;6300.968495157529;6408.391202835729;6467.029945508176;6478.125453063841;6504.284528701839;6276.968615156918;6438.195225596801;6485.675716214182;6575.57258778179;6585.506087043479;1212.2526194825537;5879.265091863517;5954.821355359346;5978.730957106919;6042.365551617083;5708;5893.8821223575505;5927.585069045169;5937.940620593804;5966.761329546813;5853.912191317134;5868.4424979626865;5937.940620593804;5938.61399009063;5942.881142377149;5855.473007429352;5868.295804503444;5925.140854576105;5937.2578427696535;5946.375630558816;5813.6802475863815;5844.26946631671;5919.289685237799;5921.407859214087;5949.702514874239;6111.816645500642;6270.46701030413;6374.87250254997;6446.774362897276;6483.351664833526;6795.592264464148;6820.829479263009;6901.792946211572;6905.896411553831;6953.89569156463;6896.931030689679;7021.684024218923;7030.367266945999;7049.506534542584;7056.153261608589;6169.167162433104;6310.400511951358;6421.486281097501;6487.416132548046;6490.026496025586;7114.679839407239;7116.92883071173;7156.856862862714;7163.06880105583;7186.209516953131;6474.935250647527;6667.833304167435;6748.055272261888;6756.83107922296;6853.0063140844295;6734.56225345351;6739.528233023641;6786.660666966731;6788.422984046312;6801.421879140328;6806.625635589991;6854.246032936373;6857.725690972405;6859.588424694534;6883.036374907517;6855.862882742317;6875.07186529812;6877.277885822016;6918.861622767517;6969.54697944632;5405.351357837006;5410.756515956791;5470.398256191816;5481.643693159932;5485.424030476823;4719.174144524694;4779.06808172403;4807.062622788592;4807.254875494304;4812.807487700453;5775.797847075416;5821.88356232873;5855.94144058554;5944.494717948936;5951.761929522857;6917.239103698589;6946.79159625212;6976.5465244758925;6980.895286570705;7002.299770022957;5917.822465326047;5943.3462319144855;5964.284285885635;6019.458248757633;6024.849378765566;5772.942270577324;5856.912146317809;5868.295804503487;5921.348651648315;6000.3999600040515;6662.600243985279;6694;6694;6704.161979752531;6711.228208756055;6812.727490900308;6898.448124150056;6905.654717264217;6909.516333856582;6914.412274956685;6687.699053542505;6716.1940567130305;6735.764248251287;6746.291639377991;6749.763758268437;6801.2178599461695;6813.931860681329;6889.862202755817;6890.827729306808;6916.377526022682;6908.1019467468905;6943.548669336477;6989.790306290819;7006.439484841302;7017.684204210721;6447.0329450582785;6570.145881035435;6577.572457790228;6580.76967306142;6584.078229047841;6588.736450541925;6602.075709400784;6694.59832410057;6698.631575263407;6706.262311145672;6659.667016649051;6703.128593282842;6707.4969377297875;6710.99335099739;6715.093462382712;6572.14562106923;6690.230623478362;6745.25802161752;6768.357006084414;6856.211535673461;6289.371062893857;6417.807465776034;6497.317781632861;6501.772437964649;6589.17635295588 11:17:59 INFO - PID 451 | |1;ext.html;834.1116710703101;853.6158728572136;859.6389516403113;864.2437866866494;870.0559892516619;39079.41380879286;43122;43238.783806081;43421.34867976983;43455;39753.80123099388;40007.599924000824;40015.39976900349;40097;40106.79946600263;7056.223815380304;7181.958616000677;7188.784336469915;7191.460640451961;7194;7045.401140903004;7142.464315176357;7147.070880785491;7155.677994490235;7158.964205178967;7101.502894797366;7118.39493643041;7125.536840105403;7132.643367831613;7699.499532530368;7766.534007959541;7850.450468467209;7862.803429914269;7866.134725180225;7866.213378662117;7505.662245198979;7688.769336919845;7738.651760670783;7762.534247945085;7778.338841198505;39474.60525394738;39975.20049599021;40065.19869602621;40108.398374024415;40254.79872600648;3527;3570.1967057412135;3572.8570857165682;3574.303010912873;3576.5708115026105;32077.1980700482;32082.19794505156;32187.51718724221;32202.194945126324;32249.1937701557;5193.428722840485;5202.193659982709;5209.505097015777;5230.97384513075;5238.214267859814;185780;186560;186806;187225;187255;42452;43275.350869736976;48632.027359452615;48703.756481217366;48905.26642100371;50980.74509627428;51124.48875511272;51159.48840511547;51188.232176517384;51364.22953655698;16282.348706051862;16402.753958690628;16444.588885277964;16472.505824825275;16485.093319867523;13354;13354.465821367037;13385.129966552144;13412.530561430303;13476;13630.522931697344;13702.314884255948;13881.167129972235;13974.790378144337;14065.718685626434;5583.5103060587135;5588.273524441796;5646.463585959327;5680.579855036241;5699.088145896637;1000.5897581991494;1011.9898801012043;1019.2050200843354;1031.1544533482472;1032.5456799008412;22641.320760377213;22715.204967826376;22773.658395124086;22815.201467948875;23107.88446057759;1105.9281146725436;1119.9720006999728;1129.9943500282445;1130.37829193943;1130.6438471881495;12058.698532536757;12090.697732556757;12181.33002684861;12206;12213.511459541518;234175;234935;235839;235984;237241;53878;54231.72884135633;54242.728786355816;54258;54288;1450.4923276853228;1481.8295895971885;1484.3839806480405;1509.9924500377429;1510.04112388634;22811.31566053021;23033.769662303162;23121.3063608092;23230.76769232286;23244;38491.23017539689;38528.229435410576;38596.6140338593;38599.6140038596;38621.4206786904;186551;187962;188164;188484;188902;33556.49665255072;34530.482042768876;36456.63543364532;36493.63506365009;36512.634873650924;45375.77312113418;47087.293690595354;47140.7642961783;47261.52738472571;47317;33746.66253337533;33843.4923476153;34011.65988340085;34050.659493404746;34270.31459370749;34081.31837363289;34165.31669366549;34167.31665366729;34599.65400345964;34699.47950780791;38018.80990595029;38339.2332153361;38372.6162738369;38501.22997540089;38606.4209036859;33358.83320583381;33439.16402089967;33601.83199083989;33773.83113084419;34350.82824585961;23132.537349253256;23672.763272367058;23722.169724059575;25390.492190156463;25504.55688482031 11:17:59 INFO - PID 451 | |2;jquery.html;551.1869991762148;565.5023579250259;567.1690972724957;568.4821526524181;590.4125395231744;21902.452438689023;22775.088996440165;22777.658335124986;22810.31569052929;22880.313590592286;23921.28236152918;24346.513069738594;24656;25807.612885806728;25966.221013369628;6416.4225219730215;6564;6602.834929126786;6604.636744979024;6608.2730899601;6164.291106522763;6455.580387274836;6493.123428337185;6540.313267106957;6557;6432.646204458753;6440.742370305205;6444.420002199801;6445.2587952385375;6445.806625801233;6446.065320528544;6448.903266451007;6450.2259728832605;6452.9354706452805;6460.580062295982;5829.912551311733;6107.5419343548965;6107.603005804653;6121;6121.724522396503;30230.24424389386;30948.845255773576;30951.69048309533;31019.53470697941;31095.37809243825;2102.516421223112;2103.516191276;2120.766715661276;2124.4795025218764;2137.5404288077984;19321.227150913946;20059.39821805348;20117.698234526495;20185.990700465063;20304.79695203044;2209.591225623265;2211.5355775287208;2248.471039693008;2257.593633146033;2267.4104732769433;120602;124548.37725811404;127451;138563;144583.27708361496;14663.239587752394;14684.41262349494;15104.0600647972;15139.54581362561;16016.199190040452;23292.06831726712;23344.182953596544;23351.41621459477;23377;23396.88301558481;10229.948850255701;10239.129673977795;10273.178145748472;10324;10444.843327350096;9689.32174747775;9697.175740062032;9750.86422696395;9753.65862194834;9888.307818452638;8676.8698469523;8916.465012099296;9216.354855160074;9230.215431688248;9236.491992940453;2679.7258372895203;2715.2668779429837;2745.876435560365;2750.22993561803;2793.5530315149476;938.9248860091176;952.8237276103943;963.1909196275162;975.8877729061248;989.0850962859327;19702.40892773219;19845.702314465296;20343.69484457734;20417.48956276105;20516.589668206554;1036.1348274191134;1054.8976319745884;1063.4842101580728;1065.7495488560182;1066.4934156275863;11092.611758588411;11187.94406027981;11239.775204495865;11374.829377559343;11423.771524569462;540632;546097;551114;567727;578862;117878.41060794641;118912.40543797398;121551;126111.36944315404;126572;1061.9362838229576;1074.7635520185547;1088.7278180454887;1107.6621630402803;1171.2503997441645;21445.46386340354;21597.568048639252;22224.88887555552;22680.206192783175;22903.77096229083;57148.42851571431;57403.42596573981;58056.2583122507;58245;58314.416855830896;67237.66381168259;67722.66138669275;67941;68345.65827170832;68428.31571684219;14709.41162353494;15118.470853520073;15228.162451065298;15266.084034957938;15273.923630381776;23795;24068.75931240665;24725;24803.503929921662;24860.875695621406;17568.736468953233;17916.104194789947;17979.640407192044;18026.72959905576;18753.6249275011;17152.313907443564;17458.30166793314;17501.64996700084;17561.473155805346;17766.28934842592;19676.50808729793;20182.69725954141;20196.59606807885;20234;20237.6964345532;14548.49080282185;14768.556943291718;14809.703805924037;14871.628209294855;14918.179500127597;19013;19045.809541904404;19053;19183.904080479508;19230.230790768772 11:17:59 INFO - PID 451 | |3;mootools.html;1368.7741522648764;1410.964725881853;1425.0737020936383;1426.0231741257232;1426.9072510286833;14763.335649895753;15375.461858834942;15391.615209619766;15404.306806193734;15411.460598879014;14929.77605335918;15137;15169.089854608732;15173.393064277416;15195.392184312614;2633.6971248306404;2768.5985532097834;2783.9721602784016;2785.4429114177246;2788.0659978907092;2709.7425744554234;2716.578930265812;2759.6826364968083;2760.1167626359575;2760.792940529458;2796.2450138462605;2835.1636267301196;2844.2604922720034;2844.559093340525;2844.715528447149;2779.7081306462833;2816.7746580273633;2823.0401663434327;2824.915252542427;2826.5901444290666;2620.6331113644105;2641.1812338175228;2648.9867550662316;2652.2838833514843;2652.681678198609;14406.495772648012;14729.705405891822;14737.263136843116;14738.631534211623;14752.114873107648;7518.736844210426;7992.840143197103;8004.959975200087;8006.719764808262;8020.799480012988;5016.197408414672;5391.568674506069;5405.945940540583;5465.672059676433;5568.777248910039;1919.1076149590367;1945.7665080190468;1974.9605007899904;1994.7905469925595;2005.3783327168478;25282.241532753862;26013.609795853077;26085.347866303495;26114.086006989855;26116.347091322677;6827;6955.1653801544135;6997.915323124924;7004.509684322048;7160.427165826722;17638.647227055644;17675.11624418774;17716;17729.822701773075;17829.197686104155;7609.201033891472;7619.580923049175;7642.5032372895585;7646.579438130956;7648.502847314907;6826.863462730717;6894;6942.132233470817;6950.131233595801;7008.859822803617;5511.366192887789;5633.915491267634;5652.717364131777;5690.2887139107615;5729.598928074995;1622.5456872075838;1678.8153303136646;1828.5611453251124;1855.5453913791207;1857.1735577668078;880.6697488441835;888.9288856891433;893.1604291965662;896.211334026066;910.886139232596;7426.628668566658;7435.219301973215;7438.293362130589;7452.515586486861;7523.3981281497345;951.3768481644533;958.8178246133352;962.6678795815433;963.4171326347599;985.8570507276405;5822.7962021329895;6004.849878752979;6083.847903802441;6127.325994140641;6209.720562574695;22118.668219976713;22253.443663908532;22335.218267360564;22387.44031399228;22390;21313;22188.88905555494;22203.22288719887;22268.443288917908;22315.553688926455;10679.199060070527;11233.157513186543;11611.59359422433;11614.070874330033;11619.477123529461;8809.779755506164;9053.185213330831;9121.224695900923;9125.133112354315;9196.770080748034;18333.26666933361;18413.63172736511;18834.434966951012;19154.425367239004;19289.5177620555;19109.808901911358;19198.328058517884;19231.615367692288;19715.11281992285;19953.501162470475;12088.395580220778;12186.634400967985;12273.202241854251;12344.321062341298;12391.93804030974;11876.228045177037;12997.675058123623;13076.346182690637;13096.148750331198;13135.671608209872;9604.51977401141;11262.774744505228;11400.543978240778;11575.536978521102;11731.530738770354;10649.520771565143;10773.89226107729;10792.244542881923;10960.12319014461;11108;10039.899601003897;10094.242931780293;10122.240831937486;10174.745631359276;10180.847287290844;7285.890711639224;7357.963210183915;7389.113306403266;7394.963025184839;7401.59291238987;7367.373773229121;7375.778726638209;7395.223501532261;7404.259574042768;7565.319121279112 11:17:59 INFO - PID 451 | |4;prototype.html;506.0549374815397;519.8986197691451;533.2747463449705;533.8505218538811;534.2876082156688;6436.710348034338;6498.902516462251;6503.683121607978;6510.739570417183;6511.3814187652215;6328.303886572473;6328.33552476989;6364;6385.860736653227;6396;5273.578113750891;5295.629305948585;5296.152615581508;5300.655457395257;5309.840704778843;4941.45643979162;5094.235864620299;5282.656627319231;5288.973555132219;5314.229436731672;5035.84892453227;5051.570616497602;5065.113605119108;5069.797208111671;5092.745362731867;5032.723200223968;5041.647084704072;5045.798168073273;5064.113780088506;5066.847994560169;4477.843275485375;4540.160070386989;4572.3827283317;4575.725456472623;4579.473360563545;6254.34329395416;6255.437010669061;6278.843028924268;6299.330677370501;6309.3690630936535;5788.8842223155725;5817.272840894888;5844.766209351621;5850.385709500484;5850.531957443394;6672.763709600839;6698.4641228701585;6707.664616769142;6714.294999025081;6736.663166841688;4953.876153096166;4982.476839931827;4983.377077865267;4988.725620090893;5002.699838009695;6633.767818126391;6711.362420570038;6761.661916904135;6864.38220560152;7028.824279392954;5037.496250374933;5049.419316778617;5058.519440653132;5062.443131255559;5063.11395505785;5030.0694371541385;5045.8738531537;5110.233464980282;5116.78088349881;5183.481651834862;5693.373728889819;5704.258446401941;5714.971425142848;5715.257016587817;5769.365369809318;6605.207375115017;6658.533902626769;6675.1322328098;6723.932760672428;6778.491613129035;1777.933240055982;1783.28668532588;1794.6321004194108;1806.6386722655523;1816.4096668582763;1182.355616189179;1218.561317925546;1228.7603917236054;1246.2335663566842;1255.7237407770276;5790.594658373873;5810.273715785527;5834.591578589543;5871.207387002785;5896.086106653475;6763.492738044666;6831.863362732817;6851.760188393382;6900.965495172492;6916.896246556205;5791.160281759121;5846;5847.6783776891825;5851.707414629337;5886.499647530008;3559.875404360835;3632.9091772705365;3646.4348026056005;3647.2493203262584;3647.963520364762;6226.875462490815;6548.410643042149;6579.736810527621;6607.108040414579;6639.834004149935;6836.248012718597;6968.721251149998;6989.33601307875;7024.789256322319;7030.437564994788;6448.419642232222;6487.772927947499;6578.605283682994;6606.900896486556;6625.933740662628;6677.632730199692;6718.382393342651;6808.65956702153;6817.250102488623;6821.93178068213;6712.765053223114;6743.52795304324;6751.864962700817;6754.5947243165565;6826.214985276757;6534.150560427114;6638.236602790547;6641.50188735837;6674.299198584273;6705.932940670531;5055.797768089235;5068.898622027613;5089.160288552347;5098.133317335987;5113.284140220298;6609.438197753053;6635.4359879410795;6722.596644201363;6755.020522024377;6840.7263709453055;6576.934230657632;6580.341965803382;6611.371919667624;6615.702293396905;6631.635260060743;6515.478761699147;6553.639549824615;6595.901061484177;6635.535512514078;6652.434543063894;6471.2234531856475;6557.967210163919;6564.5076619252795;6609;6628.701708423229;6709.161354830646;6747.392734653905;6753.15585551806;6776.797540799358;6785.423239024738;6463.385978332051;6465.967670161619;6501.902471462838;6526.151600291932;6527.2167339919515 11:17:59 INFO - PID 451 | |5;yui.html;898.4833720610649;906.3474298505074;913.8309412758636;920.9079092090792;925.3799954030799;18429.539261518436;19013.239470421184;19908.800911990875;19939;20057.197712091518;17660.735088973677;17821;17849;17905.910470447663;17925.641487170247;949.0367277213634;965.8116667249889;968.7626531499792;969.1568335548083;969.9127078562927;983.3902980152316;985.5663508056468;986.1124987511225;986.6842610364686;986.9111779939803;979.8677178580872;997.0677416615488;1015.6546774096805;1016.5374754486728;1016.6594190946042;999.4652860719481;1007.1539906478556;1007.3502590828911;1009.8030883977627;1010.1060561403137;743.5612988336853;755.3654929858944;756.6179079564839;756.8713318735828;757.2465396930035;20260.594788104303;20394.592108157754;20426.69359959602;20533.897330513402;20602.896985515126;21840.89079554592;22277.220297289517;22518.324450266355;22626.66060009101;22633.547329053326;17153.05658188799;17317.13414329291;17372.91313543437;17448.563785905328;17448.65102697939;3770.2459508098214;3802.049487628093;3803.0492376905772;3803.2583646189005;3818.064574179316;113635;141147;142134;142335;143718.28140859332;17098.316067357166;17440.47678569645;17690.5577360567;17747;17796.822031779775;31273.8436307817;31799.523007154912;31850;31861.36277274488;31875.84062079721;8641;8954.194122529003;8969.237614802685;9038.412503187272;9105.863412048824;4060.573639767841;4152.522459917088;4158.500979882433;4159.771212583337;4160.043190066302;5156.74216289184;5264.105102132647;5271.630985830955;5279.049771041173;5307.28351672527;1060;1062.925595208328;1076.1659713721929;1079.0450451350455;1080.0603474976663;697.1738489889498;703.2018658822274;711.5197241861723;713.4387449828598;721.5778769419843;12059;12123.878761212274;12527.624171274876;12709.173903696415;12794.872051279368;701.5159539917543;701.8455939693259;706.3466293678327;715.2775696546421;718.170513057409;5847.766089356463;5884.852878678067;5990.161377407167;6088.086786981989;6098.695065246809;117795;119970;120734;122060;124629;106545.46727266314;107993;108964.45517772519;109332;110615;91932.54033729923;93634;94928.52535737277;98994.01005989991;101698;12346.012319014279;12495.562655307021;12835.331406917041;12887.42006609686;13263.933680331536;42570.5742942579;43084.78457607692;44150.779246103564;44911.77544112258;45157.32264016108;75974.62012690122;76568.61715691385;78495.21504784879;81603;81846;19050.428487145407;19132.808671913102;19249;19375.8062419374;19466;21560;22723.659145112506;23467.061317547108;23588.29235122949;23698.170564030865;19485.318013869448;19560.608787824447;19655.410337689893;19971.800281996995;20808.167673292897;20212;20241;20447.182112715323;21221.575568488854;21499.677504837127;18700.438986830417;19032.52418689544;19958.20167193296;20035.09842057082;20084.096215670037;13273.800892986807;14059.718805624036;14284.642883927985;14397.496087636882;14449.711005780036;14366.066205696596;14406.495772647908;14507.347169377614;14546.272686365428;14622.34199461048 11:17:59 INFO - PID 451 | __end_tp_report 11:17:59 INFO - PID 451 | __start_cc_report 11:17:59 INFO - PID 451 | _x_x_mozilla_cycle_collect,368 11:17:59 INFO - PID 451 | __end_cc_report 11:17:59 INFO - PID 451 | __startTimestamp1504808279620__endTimestamp 11:17:59 INFO - PID 451 | 11:17:59 INFO - PID 451 | ------- Summary: start ------- 11:17:59 INFO - PID 451 | Number of tests: 6 11:17:59 INFO - PID 451 | 11:17:59 INFO - PID 451 | [#0] dojo.html Cycles:165 Average:6301.39 Median:6577.57 stddev:848.96 (12.9%) stddev-sans-first:817.98 11:17:59 INFO - PID 451 | Values: 3287.7 3289.3 3305.5 3309.5 3310.7 6301.0 6408.4 6467.0 6478.1 6504.3 6277.0 6438.2 6485.7 6575.6 6585.5 1212.3 5879.3 5954.8 5978.7 6042.4 5708.0 5893.9 5927.6 5937.9 5966.8 5853.9 5868.4 5937.9 5938.6 5942.9 5855.5 5868.3 5925.1 5937.3 5946.4 5813.7 5844.3 5919.3 5921.4 5949.7 6111.8 6270.5 6374.9 6446.8 6483.4 6795.6 6820.8 6901.8 6905.9 6953.9 6896.9 7021.7 7030.4 7049.5 7056.2 6169.2 6310.4 6421.5 6487.4 6490.0 7114.7 7116.9 7156.9 7163.1 7186.2 6474.9 6667.8 6748.1 6756.8 6853.0 6734.6 6739.5 6786.7 6788.4 6801.4 6806.6 6854.2 6857.7 6859.6 6883.0 6855.9 6875.1 6877.3 6918.9 6969.5 5405.4 5410.8 5470.4 5481.6 5485.4 4719.2 4779.1 4807.1 4807.3 4812.8 5775.8 5821.9 5855.9 5944.5 5951.8 6917.2 6946.8 6976.5 6980.9 7002.3 5917.8 5943.3 5964.3 6019.5 6024.8 5772.9 5856.9 5868.3 5921.3 6000.4 6662.6 6694.0 6694.0 6704.2 6711.2 6812.7 6898.4 6905.7 6909.5 6914.4 6687.7 6716.2 6735.8 6746.3 6749.8 6801.2 6813.9 6889.9 6890.8 6916.4 6908.1 6943.5 6989.8 7006.4 7017.7 6447.0 6570.1 6577.6 6580.8 6584.1 6588.7 6602.1 6694.6 6698.6 6706.3 6659.7 6703.1 6707.5 6711.0 6715.1 6572.1 6690.2 6745.3 6768.4 6856.2 6289.4 6417.8 6497.3 6501.8 6589.2 11:17:59 INFO - PID 451 | 11:17:59 INFO - PID 451 | [#1] ext.html Cycles:180 Average:37777.39 Median:3575.44 stddev:53059.42 (1484.0%) stddev-sans-first:53135.75 11:17:59 INFO - PID 451 | Values: 834.1 853.6 859.6 864.2 870.1 39079.4 43122.0 43238.8 43421.3 43455.0 39753.8 40007.6 40015.4 40097.0 40106.8 7056.2 7182.0 7188.8 7191.5 7194.0 7045.4 7142.5 7147.1 7155.7 7159.0 7101.5 7118.4 7125.5 7132.6 7699.5 7766.5 7850.5 7862.8 7866.1 7866.2 7505.7 7688.8 7738.7 7762.5 7778.3 39474.6 39975.2 40065.2 40108.4 40254.8 3527.0 3570.2 3572.9 3574.3 3576.6 32077.2 32082.2 32187.5 32202.2 32249.2 5193.4 5202.2 5209.5 5231.0 5238.2 185780.0 186560.0 186806.0 187225.0 187255.0 42452.0 43275.4 48632.0 48703.8 48905.3 50980.7 51124.5 51159.5 51188.2 51364.2 16282.3 16402.8 16444.6 16472.5 16485.1 13354.0 13354.5 13385.1 13412.5 13476.0 13630.5 13702.3 13881.2 13974.8 14065.7 5583.5 5588.3 5646.5 5680.6 5699.1 1000.6 1012.0 1019.2 1031.2 1032.5 22641.3 22715.2 22773.7 22815.2 23107.9 1105.9 1120.0 1130.0 1130.4 1130.6 12058.7 12090.7 12181.3 12206.0 12213.5 234175.0 234935.0 235839.0 235984.0 237241.0 53878.0 54231.7 54242.7 54258.0 54288.0 1450.5 1481.8 1484.4 1510.0 1510.0 22811.3 23033.8 23121.3 23230.8 23244.0 38491.2 38528.2 38596.6 38599.6 38621.4 186551.0 187962.0 188164.0 188484.0 188902.0 33556.5 34530.5 36456.6 36493.6 36512.6 45375.8 47087.3 47140.8 47261.5 47317.0 33746.7 33843.5 34011.7 34050.7 34270.3 34081.3 34165.3 34167.3 34599.7 34699.5 38018.8 38339.2 38372.6 38501.2 38606.4 33358.8 33439.2 33601.8 33773.8 34350.8 23132.5 23672.8 23722.2 25390.5 25504.6 11:17:59 INFO - PID 451 | 11:17:59 INFO - PID 451 | [#2] jquery.html Cycles:180 Average:36873.59 Median:22776.37 stddev:92875.65 (407.8%) stddev-sans-first:93096.15 11:17:59 INFO - PID 451 | Values: 551.2 565.5 567.2 568.5 590.4 21902.5 22775.1 22777.7 22810.3 22880.3 23921.3 24346.5 24656.0 25807.6 25966.2 6416.4 6564.0 6602.8 6604.6 6608.3 6164.3 6455.6 6493.1 6540.3 6557.0 6432.6 6440.7 6444.4 6445.3 6445.8 6446.1 6448.9 6450.2 6452.9 6460.6 5829.9 6107.5 6107.6 6121.0 6121.7 30230.2 30948.8 30951.7 31019.5 31095.4 2102.5 2103.5 2120.8 2124.5 2137.5 19321.2 20059.4 20117.7 20186.0 20304.8 2209.6 2211.5 2248.5 2257.6 2267.4 120602.0 124548.4 127451.0 138563.0 144583.3 14663.2 14684.4 15104.1 15139.5 16016.2 23292.1 23344.2 23351.4 23377.0 23396.9 10229.9 10239.1 10273.2 10324.0 10444.8 9689.3 9697.2 9750.9 9753.7 9888.3 8676.9 8916.5 9216.4 9230.2 9236.5 2679.7 2715.3 2745.9 2750.2 2793.6 938.9 952.8 963.2 975.9 989.1 19702.4 19845.7 20343.7 20417.5 20516.6 1036.1 1054.9 1063.5 1065.7 1066.5 11092.6 11187.9 11239.8 11374.8 11423.8 540632.0 546097.0 551114.0 567727.0 578862.0 117878.4 118912.4 121551.0 126111.4 126572.0 1061.9 1074.8 1088.7 1107.7 1171.3 21445.5 21597.6 22224.9 22680.2 22903.8 57148.4 57403.4 58056.3 58245.0 58314.4 67237.7 67722.7 67941.0 68345.7 68428.3 14709.4 15118.5 15228.2 15266.1 15273.9 23795.0 24068.8 24725.0 24803.5 24860.9 17568.7 17916.1 17979.6 18026.7 18753.6 17152.3 17458.3 17501.6 17561.5 17766.3 19676.5 20182.7 20196.6 20234.0 20237.7 14548.5 14768.6 14809.7 14871.6 14918.2 19013.0 19045.8 19053.0 19183.9 19230.2 11:17:59 INFO - PID 451 | 11:17:59 INFO - PID 451 | [#3] mootools.html Cycles:180 Average:9401.56 Median:2637.44 stddev:6677.79 (253.2%) stddev-sans-first:6669.25 11:17:59 INFO - PID 451 | Values: 1368.8 1411.0 1425.1 1426.0 1426.9 14763.3 15375.5 15391.6 15404.3 15411.5 14929.8 15137.0 15169.1 15173.4 15195.4 2633.7 2768.6 2784.0 2785.4 2788.1 2709.7 2716.6 2759.7 2760.1 2760.8 2796.2 2835.2 2844.3 2844.6 2844.7 2779.7 2816.8 2823.0 2824.9 2826.6 2620.6 2641.2 2649.0 2652.3 2652.7 14406.5 14729.7 14737.3 14738.6 14752.1 7518.7 7992.8 8005.0 8006.7 8020.8 5016.2 5391.6 5405.9 5465.7 5568.8 1919.1 1945.8 1975.0 1994.8 2005.4 25282.2 26013.6 26085.3 26114.1 26116.3 6827.0 6955.2 6997.9 7004.5 7160.4 17638.6 17675.1 17716.0 17729.8 17829.2 7609.2 7619.6 7642.5 7646.6 7648.5 6826.9 6894.0 6942.1 6950.1 7008.9 5511.4 5633.9 5652.7 5690.3 5729.6 1622.5 1678.8 1828.6 1855.5 1857.2 880.7 888.9 893.2 896.2 910.9 7426.6 7435.2 7438.3 7452.5 7523.4 951.4 958.8 962.7 963.4 985.9 5822.8 6004.8 6083.8 6127.3 6209.7 22118.7 22253.4 22335.2 22387.4 22390.0 21313.0 22188.9 22203.2 22268.4 22315.6 10679.2 11233.2 11611.6 11614.1 11619.5 8809.8 9053.2 9121.2 9125.1 9196.8 18333.3 18413.6 18834.4 19154.4 19289.5 19109.8 19198.3 19231.6 19715.1 19953.5 12088.4 12186.6 12273.2 12344.3 12391.9 11876.2 12997.7 13076.3 13096.1 13135.7 9604.5 11262.8 11400.5 11575.5 11731.5 10649.5 10773.9 10792.2 10960.1 11108.0 10039.9 10094.2 10122.2 10174.7 10180.8 7285.9 7358.0 7389.1 7395.0 7401.6 7367.4 7375.8 7395.2 7404.3 7565.3 11:17:59 INFO - PID 451 | 11:17:59 INFO - PID 451 | [#4] prototype.html Cycles:180 Average:5607.74 Median:6318.84 stddev:1564.82 (24.8%) stddev-sans-first:1521.64 11:17:59 INFO - PID 451 | Values: 506.1 519.9 533.3 533.9 534.3 6436.7 6498.9 6503.7 6510.7 6511.4 6328.3 6328.3 6364.0 6385.9 6396.0 5273.6 5295.6 5296.2 5300.7 5309.8 4941.5 5094.2 5282.7 5289.0 5314.2 5035.8 5051.6 5065.1 5069.8 5092.7 5032.7 5041.6 5045.8 5064.1 5066.8 4477.8 4540.2 4572.4 4575.7 4579.5 6254.3 6255.4 6278.8 6299.3 6309.4 5788.9 5817.3 5844.8 5850.4 5850.5 6672.8 6698.5 6707.7 6714.3 6736.7 4953.9 4982.5 4983.4 4988.7 5002.7 6633.8 6711.4 6761.7 6864.4 7028.8 5037.5 5049.4 5058.5 5062.4 5063.1 5030.1 5045.9 5110.2 5116.8 5183.5 5693.4 5704.3 5715.0 5715.3 5769.4 6605.2 6658.5 6675.1 6723.9 6778.5 1777.9 1783.3 1794.6 1806.6 1816.4 1182.4 1218.6 1228.8 1246.2 1255.7 5790.6 5810.3 5834.6 5871.2 5896.1 6763.5 6831.9 6851.8 6901.0 6916.9 5791.2 5846.0 5847.7 5851.7 5886.5 3559.9 3632.9 3646.4 3647.2 3648.0 6226.9 6548.4 6579.7 6607.1 6639.8 6836.2 6968.7 6989.3 7024.8 7030.4 6448.4 6487.8 6578.6 6606.9 6625.9 6677.6 6718.4 6808.7 6817.3 6821.9 6712.8 6743.5 6751.9 6754.6 6826.2 6534.2 6638.2 6641.5 6674.3 6705.9 5055.8 5068.9 5089.2 5098.1 5113.3 6609.4 6635.4 6722.6 6755.0 6840.7 6576.9 6580.3 6611.4 6615.7 6631.6 6515.5 6553.6 6595.9 6635.5 6652.4 6471.2 6558.0 6564.5 6609.0 6628.7 6709.2 6747.4 6753.2 6776.8 6785.4 6463.4 6466.0 6501.9 6526.2 6527.2 11:17:59 INFO - PID 451 | 11:17:59 INFO - PID 451 | [#5] yui.html Cycles:180 Average:25685.09 Median:21014.87 stddev:35533.62 (169.1%) stddev-sans-first:35584.55 11:17:59 INFO - PID 451 | Values: 898.5 906.3 913.8 920.9 925.4 18429.5 19013.2 19908.8 19939.0 20057.2 17660.7 17821.0 17849.0 17905.9 17925.6 949.0 965.8 968.8 969.2 969.9 983.4 985.6 986.1 986.7 986.9 979.9 997.1 1015.7 1016.5 1016.7 999.5 1007.2 1007.4 1009.8 1010.1 743.6 755.4 756.6 756.9 757.2 20260.6 20394.6 20426.7 20533.9 20602.9 21840.9 22277.2 22518.3 22626.7 22633.5 17153.1 17317.1 17372.9 17448.6 17448.7 3770.2 3802.0 3803.0 3803.3 3818.1 113635.0 141147.0 142134.0 142335.0 143718.3 17098.3 17440.5 17690.6 17747.0 17796.8 31273.8 31799.5 31850.0 31861.4 31875.8 8641.0 8954.2 8969.2 9038.4 9105.9 4060.6 4152.5 4158.5 4159.8 4160.0 5156.7 5264.1 5271.6 5279.0 5307.3 1060.0 1062.9 1076.2 1079.0 1080.1 697.2 703.2 711.5 713.4 721.6 12059.0 12123.9 12527.6 12709.2 12794.9 701.5 701.8 706.3 715.3 718.2 5847.8 5884.9 5990.2 6088.1 6098.7 117795.0 119970.0 120734.0 122060.0 124629.0 106545.5 107993.0 108964.5 109332.0 110615.0 91932.5 93634.0 94928.5 98994.0 101698.0 12346.0 12495.6 12835.3 12887.4 13263.9 42570.6 43084.8 44150.8 44911.8 45157.3 75974.6 76568.6 78495.2 81603.0 81846.0 19050.4 19132.8 19249.0 19375.8 19466.0 21560.0 22723.7 23467.1 23588.3 23698.2 19485.3 19560.6 19655.4 19971.8 20808.2 20212.0 20241.0 20447.2 21221.6 21499.7 18700.4 19032.5 19958.2 20035.1 20084.1 13273.8 14059.7 14284.6 14397.5 14449.7 14366.1 14406.5 14507.3 14546.3 14622.3 11:17:59 INFO - PID 451 | -------- Summary: end -------- 11:17:59 INFO - PID 451 | 11:18:00 INFO - TEST-INFO | 451: exit 0 11:18:00 INFO - TEST-OK | dromaeo_css | took 1110166ms 11:18:00 INFO - TEST-START | kraken 11:18:00 INFO - Initialising browser for kraken test... 11:18:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58788/getInfo.html -profile /tmp/tmpaZeX96/profile 11:18:00 INFO - TEST-INFO | started process 856 (/builds/slave/test/build/application/firefox/firefox http://localhost:58788/getInfo.html) 11:18:06 INFO - TEST-INFO | 856: exit 0 11:18:06 INFO - Browser initialized. 11:18:06 INFO - Running cycle 1/1 for kraken test... 11:18:06 INFO - Using env: {'DISPLAY': ':0', 11:18:06 INFO - 'HOME': '/home/cltbld', 11:18:06 INFO - 'JSGC_DISABLE_POISONING': '1', 11:18:06 INFO - 'LANG': 'en_US.UTF-8', 11:18:06 INFO - 'LANGUAGE': 'en_US:en', 11:18:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:18:06 INFO - 'LOGNAME': 'cltbld', 11:18:06 INFO - 'MAIL': '/var/mail/cltbld', 11:18:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:18:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:18:06 INFO - 'MOZ_CRASHREPORTER': '1', 11:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:18:06 INFO - 'MOZ_NO_REMOTE': '1', 11:18:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:06 INFO - 'NO_EM_RESTART': '1', 11:18:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:06 INFO - 'PWD': '/builds/slave/test', 11:18:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:18:06 INFO - 'RUST_BACKTRACE': 'full', 11:18:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:18:06 INFO - 'SHELL': '/bin/bash', 11:18:06 INFO - 'SHLVL': '1', 11:18:06 INFO - 'TERM': 'linux', 11:18:06 INFO - 'TMOUT': '86400', 11:18:06 INFO - 'USER': 'cltbld', 11:18:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128', 11:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:06 INFO - '_': '/tools/buildbot/bin/python'} 11:18:06 INFO - TEST-INFO | started process 1055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaZeX96/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:07 INFO - PID 1055 | 11:18:07 INFO - PID 1055 | (/builds/slave/test/build/application/firefox/firefox:1106): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:18:07 INFO - PID 1055 | 11:18:17 INFO - PID 1055 | RSS: Main: 166215680 11:18:17 INFO - PID 1055 | 11:18:20 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58788/tests/kraken/driver.html?testName=audio-beat-detection) 11:18:21 INFO - PID 1055 | RSS: Main: 172433408 11:18:21 INFO - PID 1055 | 11:18:24 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58788/tests/kraken/driver.html?testName=audio-dft) 11:18:24 INFO - PID 1055 | RSS: Main: 173178880 11:18:24 INFO - PID 1055 | 11:18:27 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58788/tests/kraken/driver.html?testName=audio-fft) 11:18:28 INFO - PID 1055 | RSS: Main: 167555072 11:18:28 INFO - PID 1055 | 11:18:30 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58788/tests/kraken/driver.html?testName=audio-oscillator) 11:18:30 INFO - PID 1055 | RSS: Main: 168353792 11:18:30 INFO - PID 1055 | 11:18:33 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58788/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:18:33 INFO - PID 1055 | RSS: Main: 168693760 11:18:33 INFO - PID 1055 | 11:18:36 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58788/tests/kraken/driver.html?testName=imaging-darkroom) 11:18:37 INFO - PID 1055 | RSS: Main: 171249664 11:18:37 INFO - PID 1055 | 11:18:41 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58788/tests/kraken/driver.html?testName=imaging-desaturate) 11:18:41 INFO - PID 1055 | RSS: Main: 170930176 11:18:41 INFO - PID 1055 | 11:18:44 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58788/tests/kraken/driver.html?testName=json-parse-financial) 11:18:45 INFO - PID 1055 | RSS: Main: 171606016 11:18:45 INFO - PID 1055 | 11:18:46 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58788/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:18:47 INFO - PID 1055 | RSS: Main: 171401216 11:18:47 INFO - PID 1055 | 11:18:49 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58788/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:18:49 INFO - PID 1055 | RSS: Main: 171585536 11:18:49 INFO - PID 1055 | 11:18:51 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58788/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:18:52 INFO - PID 1055 | RSS: Main: 172208128 11:18:52 INFO - PID 1055 | 11:18:55 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58788/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:18:55 INFO - PID 1055 | RSS: Main: 172630016 11:18:55 INFO - PID 1055 | 11:18:58 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58788/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:18:59 INFO - PID 1055 | RSS: Main: 172556288 11:18:59 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | Cycle 1(1): loaded http://localhost:58788/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58788/tests/kraken/driver.html?testName=ai-astar) 11:19:01 INFO - PID 1055 | RSS: Main: 174256128 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | __start_tp_report 11:19:01 INFO - PID 1055 | _x_x_mozilla_page_load 11:19:01 INFO - PID 1055 | _x_x_mozilla_page_load_details 11:19:01 INFO - PID 1055 | |i|pagename|runs| 11:19:01 INFO - PID 1055 | |0;ai-astar;110;107;110;107;107;108;107;109;109;106 11:19:01 INFO - PID 1055 | |1;audio-beat-detection;115;118;118;116;115;115;118;116;115;117 11:19:01 INFO - PID 1055 | |2;audio-dft;164;165;164;164;162;164;170;183;163;165 11:19:01 INFO - PID 1055 | |3;audio-fft;76;75;77;76;74;80;78;74;74;73 11:19:01 INFO - PID 1055 | |4;audio-oscillator;79;80;77;79;79;80;80;79;79;89 11:19:01 INFO - PID 1055 | |5;imaging-gaussian-blur;115;115;114;113;114;115;114;111;115;115 11:19:01 INFO - PID 1055 | |6;imaging-darkroom;148;149;148;160;148;151;150;151;149;151 11:19:01 INFO - PID 1055 | |7;imaging-desaturate;94;94;94;95;95;99;100;94;95;94 11:19:01 INFO - PID 1055 | |8;json-parse-financial;52;53;52;54;51;53;52;52;52;52 11:19:01 INFO - PID 1055 | |9;json-stringify-tinderbox;37;38;38;38;39;38;38;40;38;38 11:19:01 INFO - PID 1055 | |10;stanford-crypto-aes;84;76;81;76;74;75;74;77;81;77 11:19:01 INFO - PID 1055 | |11;stanford-crypto-ccm;121;116;118;120;127;120;118;121;128;127 11:19:01 INFO - PID 1055 | |12;stanford-crypto-pbkdf2;172;169;168;173;181;169;174;172;171;167 11:19:01 INFO - PID 1055 | |13;stanford-crypto-sha256-iterative;70;65;63;66;67;65;62;73;63;65 11:19:01 INFO - PID 1055 | __end_tp_report 11:19:01 INFO - PID 1055 | __start_cc_report 11:19:01 INFO - PID 1055 | _x_x_mozilla_cycle_collect,939 11:19:01 INFO - PID 1055 | __end_cc_report 11:19:01 INFO - PID 1055 | __startTimestamp1504808341562__endTimestamp 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | ------- Summary: start ------- 11:19:01 INFO - PID 1055 | Number of tests: 14 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.50 stddev:1.41 (1.3%) stddev-sans-first:1.30 11:19:01 INFO - PID 1055 | Values: 110.0 107.0 110.0 107.0 107.0 108.0 107.0 109.0 109.0 106.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#1] audio-beat-detection Cycles:10 Average:116.30 Median:116.50 stddev:1.34 (1.1%) stddev-sans-first:1.33 11:19:01 INFO - PID 1055 | Values: 115.0 118.0 118.0 116.0 115.0 115.0 118.0 116.0 115.0 117.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#2] audio-dft Cycles:10 Average:166.40 Median:164.50 stddev:6.20 (3.8%) stddev-sans-first:6.52 11:19:01 INFO - PID 1055 | Values: 164.0 165.0 164.0 164.0 162.0 164.0 170.0 183.0 163.0 165.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#3] audio-fft Cycles:10 Average:75.70 Median:76.00 stddev:2.16 (2.8%) stddev-sans-first:2.29 11:19:01 INFO - PID 1055 | Values: 76.0 75.0 77.0 76.0 74.0 80.0 78.0 74.0 74.0 73.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:79.50 stddev:3.25 (4.1%) stddev-sans-first:3.42 11:19:01 INFO - PID 1055 | Values: 79.0 80.0 77.0 79.0 79.0 80.0 80.0 79.0 79.0 89.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:115.00 stddev:1.29 (1.1%) stddev-sans-first:1.32 11:19:01 INFO - PID 1055 | Values: 115.0 115.0 114.0 113.0 114.0 115.0 114.0 111.0 115.0 115.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:3.57 (2.4%) stddev-sans-first:3.67 11:19:01 INFO - PID 1055 | Values: 148.0 149.0 148.0 160.0 148.0 151.0 150.0 151.0 149.0 151.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:94.50 stddev:2.22 (2.4%) stddev-sans-first:2.30 11:19:01 INFO - PID 1055 | Values: 94.0 94.0 94.0 95.0 95.0 99.0 100.0 94.0 95.0 94.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 11:19:01 INFO - PID 1055 | Values: 52.0 53.0 52.0 54.0 51.0 53.0 52.0 52.0 52.0 52.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.79 (2.1%) stddev-sans-first:0.71 11:19:01 INFO - PID 1055 | Values: 37.0 38.0 38.0 38.0 39.0 38.0 38.0 40.0 38.0 38.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.00 stddev:3.37 (4.4%) stddev-sans-first:2.64 11:19:01 INFO - PID 1055 | Values: 84.0 76.0 81.0 76.0 74.0 75.0 74.0 77.0 81.0 77.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:121.00 stddev:4.25 (3.5%) stddev-sans-first:4.50 11:19:01 INFO - PID 1055 | Values: 121.0 116.0 118.0 120.0 127.0 120.0 118.0 121.0 128.0 127.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:172.00 stddev:4.01 (2.3%) stddev-sans-first:4.25 11:19:01 INFO - PID 1055 | Values: 172.0 169.0 168.0 173.0 181.0 169.0 174.0 172.0 171.0 167.0 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:65.50 stddev:3.38 (5.2%) stddev-sans-first:3.24 11:19:01 INFO - PID 1055 | Values: 70.0 65.0 63.0 66.0 67.0 65.0 62.0 73.0 63.0 65.0 11:19:01 INFO - PID 1055 | -------- Summary: end -------- 11:19:01 INFO - PID 1055 | 11:19:01 INFO - PID 1055 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:19:02 INFO - TEST-INFO | 1055: exit 0 11:19:02 INFO - TEST-OK | kraken | took 61841ms 11:19:02 INFO - SUITE-END | took 1172s 11:19:02 INFO - Completed test suite (00:19:32) 11:19:02 INFO - javascript benchmark 11:19:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8707.079266545474, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3287.6876696713816, 3289.3256882339124, 3305.520699498573, 3309.5035744638303, 3310.6689331066896, 6300.968495157529, 6408.391202835729, 6467.029945508176, 6478.125453063841, 6504.284528701839, 6276.968615156918, 6438.195225596801, 6485.675716214182, 6575.57258778179, 6585.506087043479, 1212.2526194825537, 5879.265091863517, 5954.821355359346, 5978.730957106919, 6042.365551617083, 5708.0, 5893.8821223575505, 5927.585069045169, 5937.940620593804, 5966.761329546813, 5853.912191317134, 5868.4424979626865, 5937.940620593804, 5938.61399009063, 5942.881142377149, 5855.473007429352, 5868.295804503444, 5925.140854576105, 5937.2578427696535, 5946.375630558816, 5813.6802475863815, 5844.26946631671, 5919.289685237799, 5921.407859214087, 5949.702514874239, 6111.816645500642, 6270.46701030413, 6374.87250254997, 6446.774362897276, 6483.351664833526, 6795.592264464148, 6820.829479263009, 6901.792946211572, 6905.896411553831, 6953.89569156463, 6896.931030689679, 7021.684024218923, 7030.367266945999, 7049.506534542584, 7056.153261608589, 6169.167162433104, 6310.400511951358, 6421.486281097501, 6487.416132548046, 6490.026496025586, 7114.679839407239, 7116.92883071173, 7156.856862862714, 7163.06880105583, 7186.209516953131, 6474.935250647527, 6667.833304167435, 6748.055272261888, 6756.83107922296, 6853.0063140844295, 6734.56225345351, 6739.528233023641, 6786.660666966731, 6788.422984046312, 6801.421879140328, 6806.625635589991, 6854.246032936373, 6857.725690972405, 6859.588424694534, 6883.036374907517, 6855.862882742317, 6875.07186529812, 6877.277885822016, 6918.861622767517, 6969.54697944632, 5405.351357837006, 5410.756515956791, 5470.398256191816, 5481.643693159932, 5485.424030476823, 4719.174144524694, 4779.06808172403, 4807.062622788592, 4807.254875494304, 4812.807487700453, 5775.797847075416, 5821.88356232873, 5855.94144058554, 5944.494717948936, 5951.761929522857, 6917.239103698589, 6946.79159625212, 6976.5465244758925, 6980.895286570705, 7002.299770022957, 5917.822465326047, 5943.3462319144855, 5964.284285885635, 6019.458248757633, 6024.849378765566, 5772.942270577324, 5856.912146317809, 5868.295804503487, 5921.348651648315, 6000.3999600040515, 6662.600243985279, 6694.0, 6694.0, 6704.161979752531, 6711.228208756055, 6812.727490900308, 6898.448124150056, 6905.654717264217, 6909.516333856582, 6914.412274956685, 6687.699053542505, 6716.1940567130305, 6735.764248251287, 6746.291639377991, 6749.763758268437, 6801.2178599461695, 6813.931860681329, 6889.862202755817, 6890.827729306808, 6916.377526022682, 6908.1019467468905, 6943.548669336477, 6989.790306290819, 7006.439484841302, 7017.684204210721, 6447.0329450582785, 6570.145881035435, 6577.572457790228, 6580.76967306142, 6584.078229047841, 6588.736450541925, 6602.075709400784, 6694.59832410057, 6698.631575263407, 6706.262311145672, 6659.667016649051, 6703.128593282842, 6707.4969377297875, 6710.99335099739, 6715.093462382712, 6572.14562106923, 6690.230623478362, 6745.25802161752, 6768.357006084414, 6856.211535673461, 6289.371062893857, 6417.807465776034, 6497.317781632861, 6501.772437964649, 6589.17635295588], "value": 6241.664417292923, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.1116710703101, 853.6158728572136, 859.6389516403113, 864.2437866866494, 870.0559892516619, 39079.41380879286, 43122.0, 43238.783806081, 43421.34867976983, 43455.0, 39753.80123099388, 40007.599924000824, 40015.39976900349, 40097.0, 40106.79946600263, 7056.223815380304, 7181.958616000677, 7188.784336469915, 7191.460640451961, 7194.0, 7045.401140903004, 7142.464315176357, 7147.070880785491, 7155.677994490235, 7158.964205178967, 7101.502894797366, 7118.39493643041, 7125.536840105403, 7132.643367831613, 7699.499532530368, 7766.534007959541, 7850.450468467209, 7862.803429914269, 7866.134725180225, 7866.213378662117, 7505.662245198979, 7688.769336919845, 7738.651760670783, 7762.534247945085, 7778.338841198505, 39474.60525394738, 39975.20049599021, 40065.19869602621, 40108.398374024415, 40254.79872600648, 3527.0, 3570.1967057412135, 3572.8570857165682, 3574.303010912873, 3576.5708115026105, 32077.1980700482, 32082.19794505156, 32187.51718724221, 32202.194945126324, 32249.1937701557, 5193.428722840485, 5202.193659982709, 5209.505097015777, 5230.97384513075, 5238.214267859814, 185780.0, 186560.0, 186806.0, 187225.0, 187255.0, 42452.0, 43275.350869736976, 48632.027359452615, 48703.756481217366, 48905.26642100371, 50980.74509627428, 51124.48875511272, 51159.48840511547, 51188.232176517384, 51364.22953655698, 16282.348706051862, 16402.753958690628, 16444.588885277964, 16472.505824825275, 16485.093319867523, 13354.0, 13354.465821367037, 13385.129966552144, 13412.530561430303, 13476.0, 13630.522931697344, 13702.314884255948, 13881.167129972235, 13974.790378144337, 14065.718685626434, 5583.5103060587135, 5588.273524441796, 5646.463585959327, 5680.579855036241, 5699.088145896637, 1000.5897581991494, 1011.9898801012043, 1019.2050200843354, 1031.1544533482472, 1032.5456799008412, 22641.320760377213, 22715.204967826376, 22773.658395124086, 22815.201467948875, 23107.88446057759, 1105.9281146725436, 1119.9720006999728, 1129.9943500282445, 1130.37829193943, 1130.6438471881495, 12058.698532536757, 12090.697732556757, 12181.33002684861, 12206.0, 12213.511459541518, 234175.0, 234935.0, 235839.0, 235984.0, 237241.0, 53878.0, 54231.72884135633, 54242.728786355816, 54258.0, 54288.0, 1450.4923276853228, 1481.8295895971885, 1484.3839806480405, 1509.9924500377429, 1510.04112388634, 22811.31566053021, 23033.769662303162, 23121.3063608092, 23230.76769232286, 23244.0, 38491.23017539689, 38528.229435410576, 38596.6140338593, 38599.6140038596, 38621.4206786904, 186551.0, 187962.0, 188164.0, 188484.0, 188902.0, 33556.49665255072, 34530.482042768876, 36456.63543364532, 36493.63506365009, 36512.634873650924, 45375.77312113418, 47087.293690595354, 47140.7642961783, 47261.52738472571, 47317.0, 33746.66253337533, 33843.4923476153, 34011.65988340085, 34050.659493404746, 34270.31459370749, 34081.31837363289, 34165.31669366549, 34167.31665366729, 34599.65400345964, 34699.47950780791, 38018.80990595029, 38339.2332153361, 38372.6162738369, 38501.22997540089, 38606.4209036859, 33358.83320583381, 33439.16402089967, 33601.83199083989, 33773.83113084419, 34350.82824585961, 23132.537349253256, 23672.763272367058, 23722.169724059575, 25390.492190156463, 25504.55688482031], "value": 17290.750477391564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.1869991762148, 565.5023579250259, 567.1690972724957, 568.4821526524181, 590.4125395231744, 21902.452438689023, 22775.088996440165, 22777.658335124986, 22810.31569052929, 22880.313590592286, 23921.28236152918, 24346.513069738594, 24656.0, 25807.612885806728, 25966.221013369628, 6416.4225219730215, 6564.0, 6602.834929126786, 6604.636744979024, 6608.2730899601, 6164.291106522763, 6455.580387274836, 6493.123428337185, 6540.313267106957, 6557.0, 6432.646204458753, 6440.742370305205, 6444.420002199801, 6445.2587952385375, 6445.806625801233, 6446.065320528544, 6448.903266451007, 6450.2259728832605, 6452.9354706452805, 6460.580062295982, 5829.912551311733, 6107.5419343548965, 6107.603005804653, 6121.0, 6121.724522396503, 30230.24424389386, 30948.845255773576, 30951.69048309533, 31019.53470697941, 31095.37809243825, 2102.516421223112, 2103.516191276, 2120.766715661276, 2124.4795025218764, 2137.5404288077984, 19321.227150913946, 20059.39821805348, 20117.698234526495, 20185.990700465063, 20304.79695203044, 2209.591225623265, 2211.5355775287208, 2248.471039693008, 2257.593633146033, 2267.4104732769433, 120602.0, 124548.37725811404, 127451.0, 138563.0, 144583.27708361496, 14663.239587752394, 14684.41262349494, 15104.0600647972, 15139.54581362561, 16016.199190040452, 23292.06831726712, 23344.182953596544, 23351.41621459477, 23377.0, 23396.88301558481, 10229.948850255701, 10239.129673977795, 10273.178145748472, 10324.0, 10444.843327350096, 9689.32174747775, 9697.175740062032, 9750.86422696395, 9753.65862194834, 9888.307818452638, 8676.8698469523, 8916.465012099296, 9216.354855160074, 9230.215431688248, 9236.491992940453, 2679.7258372895203, 2715.2668779429837, 2745.876435560365, 2750.22993561803, 2793.5530315149476, 938.9248860091176, 952.8237276103943, 963.1909196275162, 975.8877729061248, 989.0850962859327, 19702.40892773219, 19845.702314465296, 20343.69484457734, 20417.48956276105, 20516.589668206554, 1036.1348274191134, 1054.8976319745884, 1063.4842101580728, 1065.7495488560182, 1066.4934156275863, 11092.611758588411, 11187.94406027981, 11239.775204495865, 11374.829377559343, 11423.771524569462, 540632.0, 546097.0, 551114.0, 567727.0, 578862.0, 117878.41060794641, 118912.40543797398, 121551.0, 126111.36944315404, 126572.0, 1061.9362838229576, 1074.7635520185547, 1088.7278180454887, 1107.6621630402803, 1171.2503997441645, 21445.46386340354, 21597.568048639252, 22224.88887555552, 22680.206192783175, 22903.77096229083, 57148.42851571431, 57403.42596573981, 58056.2583122507, 58245.0, 58314.416855830896, 67237.66381168259, 67722.66138669275, 67941.0, 68345.65827170832, 68428.31571684219, 14709.41162353494, 15118.470853520073, 15228.162451065298, 15266.084034957938, 15273.923630381776, 23795.0, 24068.75931240665, 24725.0, 24803.503929921662, 24860.875695621406, 17568.736468953233, 17916.104194789947, 17979.640407192044, 18026.72959905576, 18753.6249275011, 17152.313907443564, 17458.30166793314, 17501.64996700084, 17561.473155805346, 17766.28934842592, 19676.50808729793, 20182.69725954141, 20196.59606807885, 20234.0, 20237.6964345532, 14548.49080282185, 14768.556943291718, 14809.703805924037, 14871.628209294855, 14918.179500127597, 19013.0, 19045.809541904404, 19053.0, 19183.904080479508, 19230.230790768772], "value": 12164.969717915104, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.7741522648764, 1410.964725881853, 1425.0737020936383, 1426.0231741257232, 1426.9072510286833, 14763.335649895753, 15375.461858834942, 15391.615209619766, 15404.306806193734, 15411.460598879014, 14929.77605335918, 15137.0, 15169.089854608732, 15173.393064277416, 15195.392184312614, 2633.6971248306404, 2768.5985532097834, 2783.9721602784016, 2785.4429114177246, 2788.0659978907092, 2709.7425744554234, 2716.578930265812, 2759.6826364968083, 2760.1167626359575, 2760.792940529458, 2796.2450138462605, 2835.1636267301196, 2844.2604922720034, 2844.559093340525, 2844.715528447149, 2779.7081306462833, 2816.7746580273633, 2823.0401663434327, 2824.915252542427, 2826.5901444290666, 2620.6331113644105, 2641.1812338175228, 2648.9867550662316, 2652.2838833514843, 2652.681678198609, 14406.495772648012, 14729.705405891822, 14737.263136843116, 14738.631534211623, 14752.114873107648, 7518.736844210426, 7992.840143197103, 8004.959975200087, 8006.719764808262, 8020.799480012988, 5016.197408414672, 5391.568674506069, 5405.945940540583, 5465.672059676433, 5568.777248910039, 1919.1076149590367, 1945.7665080190468, 1974.9605007899904, 1994.7905469925595, 2005.3783327168478, 25282.241532753862, 26013.609795853077, 26085.347866303495, 26114.086006989855, 26116.347091322677, 6827.0, 6955.1653801544135, 6997.915323124924, 7004.509684322048, 7160.427165826722, 17638.647227055644, 17675.11624418774, 17716.0, 17729.822701773075, 17829.197686104155, 7609.201033891472, 7619.580923049175, 7642.5032372895585, 7646.579438130956, 7648.502847314907, 6826.863462730717, 6894.0, 6942.132233470817, 6950.131233595801, 7008.859822803617, 5511.366192887789, 5633.915491267634, 5652.717364131777, 5690.2887139107615, 5729.598928074995, 1622.5456872075838, 1678.8153303136646, 1828.5611453251124, 1855.5453913791207, 1857.1735577668078, 880.6697488441835, 888.9288856891433, 893.1604291965662, 896.211334026066, 910.886139232596, 7426.628668566658, 7435.219301973215, 7438.293362130589, 7452.515586486861, 7523.3981281497345, 951.3768481644533, 958.8178246133352, 962.6678795815433, 963.4171326347599, 985.8570507276405, 5822.7962021329895, 6004.849878752979, 6083.847903802441, 6127.325994140641, 6209.720562574695, 22118.668219976713, 22253.443663908532, 22335.218267360564, 22387.44031399228, 22390.0, 21313.0, 22188.88905555494, 22203.22288719887, 22268.443288917908, 22315.553688926455, 10679.199060070527, 11233.157513186543, 11611.59359422433, 11614.070874330033, 11619.477123529461, 8809.779755506164, 9053.185213330831, 9121.224695900923, 9125.133112354315, 9196.770080748034, 18333.26666933361, 18413.63172736511, 18834.434966951012, 19154.425367239004, 19289.5177620555, 19109.808901911358, 19198.328058517884, 19231.615367692288, 19715.11281992285, 19953.501162470475, 12088.395580220778, 12186.634400967985, 12273.202241854251, 12344.321062341298, 12391.93804030974, 11876.228045177037, 12997.675058123623, 13076.346182690637, 13096.148750331198, 13135.671608209872, 9604.51977401141, 11262.774744505228, 11400.543978240778, 11575.536978521102, 11731.530738770354, 10649.520771565143, 10773.89226107729, 10792.244542881923, 10960.12319014461, 11108.0, 10039.899601003897, 10094.242931780293, 10122.240831937486, 10174.745631359276, 10180.847287290844, 7285.890711639224, 7357.963210183915, 7389.113306403266, 7394.963025184839, 7401.59291238987, 7367.373773229121, 7375.778726638209, 7395.223501532261, 7404.259574042768, 7565.319121279112], "value": 6774.414294614699, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.0549374815397, 519.8986197691451, 533.2747463449705, 533.8505218538811, 534.2876082156688, 6436.710348034338, 6498.902516462251, 6503.683121607978, 6510.739570417183, 6511.3814187652215, 6328.303886572473, 6328.33552476989, 6364.0, 6385.860736653227, 6396.0, 5273.578113750891, 5295.629305948585, 5296.152615581508, 5300.655457395257, 5309.840704778843, 4941.45643979162, 5094.235864620299, 5282.656627319231, 5288.973555132219, 5314.229436731672, 5035.84892453227, 5051.570616497602, 5065.113605119108, 5069.797208111671, 5092.745362731867, 5032.723200223968, 5041.647084704072, 5045.798168073273, 5064.113780088506, 5066.847994560169, 4477.843275485375, 4540.160070386989, 4572.3827283317, 4575.725456472623, 4579.473360563545, 6254.34329395416, 6255.437010669061, 6278.843028924268, 6299.330677370501, 6309.3690630936535, 5788.8842223155725, 5817.272840894888, 5844.766209351621, 5850.385709500484, 5850.531957443394, 6672.763709600839, 6698.4641228701585, 6707.664616769142, 6714.294999025081, 6736.663166841688, 4953.876153096166, 4982.476839931827, 4983.377077865267, 4988.725620090893, 5002.699838009695, 6633.767818126391, 6711.362420570038, 6761.661916904135, 6864.38220560152, 7028.824279392954, 5037.496250374933, 5049.419316778617, 5058.519440653132, 5062.443131255559, 5063.11395505785, 5030.0694371541385, 5045.8738531537, 5110.233464980282, 5116.78088349881, 5183.481651834862, 5693.373728889819, 5704.258446401941, 5714.971425142848, 5715.257016587817, 5769.365369809318, 6605.207375115017, 6658.533902626769, 6675.1322328098, 6723.932760672428, 6778.491613129035, 1777.933240055982, 1783.28668532588, 1794.6321004194108, 1806.6386722655523, 1816.4096668582763, 1182.355616189179, 1218.561317925546, 1228.7603917236054, 1246.2335663566842, 1255.7237407770276, 5790.594658373873, 5810.273715785527, 5834.591578589543, 5871.207387002785, 5896.086106653475, 6763.492738044666, 6831.863362732817, 6851.760188393382, 6900.965495172492, 6916.896246556205, 5791.160281759121, 5846.0, 5847.6783776891825, 5851.707414629337, 5886.499647530008, 3559.875404360835, 3632.9091772705365, 3646.4348026056005, 3647.2493203262584, 3647.963520364762, 6226.875462490815, 6548.410643042149, 6579.736810527621, 6607.108040414579, 6639.834004149935, 6836.248012718597, 6968.721251149998, 6989.33601307875, 7024.789256322319, 7030.437564994788, 6448.419642232222, 6487.772927947499, 6578.605283682994, 6606.900896486556, 6625.933740662628, 6677.632730199692, 6718.382393342651, 6808.65956702153, 6817.250102488623, 6821.93178068213, 6712.765053223114, 6743.52795304324, 6751.864962700817, 6754.5947243165565, 6826.214985276757, 6534.150560427114, 6638.236602790547, 6641.50188735837, 6674.299198584273, 6705.932940670531, 5055.797768089235, 5068.898622027613, 5089.160288552347, 5098.133317335987, 5113.284140220298, 6609.438197753053, 6635.4359879410795, 6722.596644201363, 6755.020522024377, 6840.7263709453055, 6576.934230657632, 6580.341965803382, 6611.371919667624, 6615.702293396905, 6631.635260060743, 6515.478761699147, 6553.639549824615, 6595.901061484177, 6635.535512514078, 6652.434543063894, 6471.2234531856475, 6557.967210163919, 6564.5076619252795, 6609.0, 6628.701708423229, 6709.161354830646, 6747.392734653905, 6753.15585551806, 6776.797540799358, 6785.423239024738, 6463.385978332051, 6465.967670161619, 6501.902471462838, 6526.151600291932, 6527.2167339919515], "value": 5146.43483449169, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.4833720610649, 906.3474298505074, 913.8309412758636, 920.9079092090792, 925.3799954030799, 18429.539261518436, 19013.239470421184, 19908.800911990875, 19939.0, 20057.197712091518, 17660.735088973677, 17821.0, 17849.0, 17905.910470447663, 17925.641487170247, 949.0367277213634, 965.8116667249889, 968.7626531499792, 969.1568335548083, 969.9127078562927, 983.3902980152316, 985.5663508056468, 986.1124987511225, 986.6842610364686, 986.9111779939803, 979.8677178580872, 997.0677416615488, 1015.6546774096805, 1016.5374754486728, 1016.6594190946042, 999.4652860719481, 1007.1539906478556, 1007.3502590828911, 1009.8030883977627, 1010.1060561403137, 743.5612988336853, 755.3654929858944, 756.6179079564839, 756.8713318735828, 757.2465396930035, 20260.594788104303, 20394.592108157754, 20426.69359959602, 20533.897330513402, 20602.896985515126, 21840.89079554592, 22277.220297289517, 22518.324450266355, 22626.66060009101, 22633.547329053326, 17153.05658188799, 17317.13414329291, 17372.91313543437, 17448.563785905328, 17448.65102697939, 3770.2459508098214, 3802.049487628093, 3803.0492376905772, 3803.2583646189005, 3818.064574179316, 113635.0, 141147.0, 142134.0, 142335.0, 143718.28140859332, 17098.316067357166, 17440.47678569645, 17690.5577360567, 17747.0, 17796.822031779775, 31273.8436307817, 31799.523007154912, 31850.0, 31861.36277274488, 31875.84062079721, 8641.0, 8954.194122529003, 8969.237614802685, 9038.412503187272, 9105.863412048824, 4060.573639767841, 4152.522459917088, 4158.500979882433, 4159.771212583337, 4160.043190066302, 5156.74216289184, 5264.105102132647, 5271.630985830955, 5279.049771041173, 5307.28351672527, 1060.0, 1062.925595208328, 1076.1659713721929, 1079.0450451350455, 1080.0603474976663, 697.1738489889498, 703.2018658822274, 711.5197241861723, 713.4387449828598, 721.5778769419843, 12059.0, 12123.878761212274, 12527.624171274876, 12709.173903696415, 12794.872051279368, 701.5159539917543, 701.8455939693259, 706.3466293678327, 715.2775696546421, 718.170513057409, 5847.766089356463, 5884.852878678067, 5990.161377407167, 6088.086786981989, 6098.695065246809, 117795.0, 119970.0, 120734.0, 122060.0, 124629.0, 106545.46727266314, 107993.0, 108964.45517772519, 109332.0, 110615.0, 91932.54033729923, 93634.0, 94928.52535737277, 98994.01005989991, 101698.0, 12346.012319014279, 12495.562655307021, 12835.331406917041, 12887.42006609686, 13263.933680331536, 42570.5742942579, 43084.78457607692, 44150.779246103564, 44911.77544112258, 45157.32264016108, 75974.62012690122, 76568.61715691385, 78495.21504784879, 81603.0, 81846.0, 19050.428487145407, 19132.808671913102, 19249.0, 19375.8062419374, 19466.0, 21560.0, 22723.659145112506, 23467.061317547108, 23588.29235122949, 23698.170564030865, 19485.318013869448, 19560.608787824447, 19655.410337689893, 19971.800281996995, 20808.167673292897, 20212.0, 20241.0, 20447.182112715323, 21221.575568488854, 21499.677504837127, 18700.438986830417, 19032.52418689544, 19958.20167193296, 20035.09842057082, 20084.096215670037, 13273.800892986807, 14059.718805624036, 14284.642883927985, 14397.496087636882, 14449.711005780036, 14366.066205696596, 14406.495772647908, 14507.347169377614, 14546.272686365428, 14622.34199461048], "value": 9519.326609938536, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1433.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 110.0, 107.0, 107.0, 108.0, 107.0, 109.0, 109.0, 106.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 118.0, 116.0, 115.0, 115.0, 118.0, 116.0, 115.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 164.0, 162.0, 164.0, 170.0, 183.0, 163.0, 165.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 76.0, 74.0, 80.0, 78.0, 74.0, 74.0, 73.0], "value": 75.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 77.0, 79.0, 79.0, 80.0, 80.0, 79.0, 79.0, 89.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 113.0, 114.0, 115.0, 114.0, 111.0, 115.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 160.0, 148.0, 151.0, 150.0, 151.0, 149.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 99.0, 100.0, 94.0, 95.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 54.0, 51.0, 53.0, 52.0, 52.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 40.0, 38.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 81.0, 76.0, 74.0, 75.0, 74.0, 77.0, 81.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 116.0, 118.0, 120.0, 127.0, 120.0, 118.0, 121.0, 128.0, 127.0], "value": 121.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 168.0, 173.0, 181.0, 169.0, 174.0, 172.0, 171.0, 167.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 63.0, 66.0, 67.0, 65.0, 62.0, 73.0, 63.0, 65.0], "value": 65.9, "unit": "score"}]}]} 11:19:02 INFO - Return code: 0 11:19:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:19:02 INFO - # TBPL SUCCESS # 11:19:02 INFO - Running post-action listener: _package_coverage_data 11:19:02 INFO - Running post-action listener: _resource_record_post_action 11:19:02 INFO - [mozharness: 2017-09-07 18:19:02.851097Z] Finished run-tests step (success) 11:19:02 INFO - Running post-run listener: _resource_record_post_run 11:19:02 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 390639616; Read time: 0; Write time: 217676 11:19:02 INFO - TinderboxPrint: CPU usage
13.1% 11:19:02 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:19:02 INFO - TinderboxPrint: I/O write bytes / time
390,639,616 / 217,676 11:19:02 INFO - TinderboxPrint: CPU idle
8,234.4 (86.9%) 11:19:02 INFO - TinderboxPrint: CPU user
1,194.3 (12.6%) 11:19:02 INFO - TinderboxPrint: Swap in / out
0 / 0 11:19:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106258432; Read time: 0; Write time: 88244 11:19:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:19:02 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 284381184; Read time: 0; Write time: 129432 11:19:03 INFO - Running post-run listener: _upload_blobber_files 11:19:03 INFO - Blob upload gear active. 11:19:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:19:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:19:04 INFO - (blobuploader) - INFO - Open directory for files ... 11:19:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:19:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:19:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:05 INFO - (blobuploader) - INFO - Done attempting. 11:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:19:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:07 INFO - (blobuploader) - INFO - Done attempting. 11:19:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:19:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:19:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:11 INFO - (blobuploader) - INFO - Done attempting. 11:19:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:19:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:19:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:13 INFO - (blobuploader) - INFO - Done attempting. 11:19:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:19:13 INFO - Return code: 0 11:19:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:19:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:19:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/238e37c77167240401ae381bc4aae186da7bb566dc8cc8e19b6c9bf19923070e2f2f9a0b58da6db68837e5ae40cff79e7413717ac67f2e4798556adbcdce365f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e02aac62c77177006939e8c75817f3c636215b2e942186ce20ce9e11e53a0cf6fe4d021f634e2bbd181df69fcaf291856abeb9a1fb574acd7f432447338f0de4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31477e425246e424f470c11a91df8f69faa0eeccdd649e21c7f9f62f2cc2eb02603f0893b8073508f9e63990168b7cd5c6027af53bd5de067c9aab9f63e1dbfa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c6b02d798cf2f30613be3cb27dbca91c45dd07291a7784301ea7fa33d618526c47baa25c1ec6ba74e6ea2e76ebc43cf364842d5c2564f4ed5cabda9626c7ef3"} 11:19:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:19:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:19:13 INFO - Contents: 11:19:13 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/238e37c77167240401ae381bc4aae186da7bb566dc8cc8e19b6c9bf19923070e2f2f9a0b58da6db68837e5ae40cff79e7413717ac67f2e4798556adbcdce365f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e02aac62c77177006939e8c75817f3c636215b2e942186ce20ce9e11e53a0cf6fe4d021f634e2bbd181df69fcaf291856abeb9a1fb574acd7f432447338f0de4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31477e425246e424f470c11a91df8f69faa0eeccdd649e21c7f9f62f2cc2eb02603f0893b8073508f9e63990168b7cd5c6027af53bd5de067c9aab9f63e1dbfa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c6b02d798cf2f30613be3cb27dbca91c45dd07291a7784301ea7fa33d618526c47baa25c1ec6ba74e6ea2e76ebc43cf364842d5c2564f4ed5cabda9626c7ef3"} 11:19:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:19:13 INFO - Copying logs to upload dir... 11:19:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:19:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.297535 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-07 11:19:13.684481) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 11:19:13.688385) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128 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-Non-PGO/sha512/238e37c77167240401ae381bc4aae186da7bb566dc8cc8e19b6c9bf19923070e2f2f9a0b58da6db68837e5ae40cff79e7413717ac67f2e4798556adbcdce365f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e02aac62c77177006939e8c75817f3c636215b2e942186ce20ce9e11e53a0cf6fe4d021f634e2bbd181df69fcaf291856abeb9a1fb574acd7f432447338f0de4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31477e425246e424f470c11a91df8f69faa0eeccdd649e21c7f9f62f2cc2eb02603f0893b8073508f9e63990168b7cd5c6027af53bd5de067c9aab9f63e1dbfa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c6b02d798cf2f30613be3cb27dbca91c45dd07291a7784301ea7fa33d618526c47baa25c1ec6ba74e6ea2e76ebc43cf364842d5c2564f4ed5cabda9626c7ef3"} build_url:https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/ErCwGB7lSTS6L7N4qpQiKw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/238e37c77167240401ae381bc4aae186da7bb566dc8cc8e19b6c9bf19923070e2f2f9a0b58da6db68837e5ae40cff79e7413717ac67f2e4798556adbcdce365f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e02aac62c77177006939e8c75817f3c636215b2e942186ce20ce9e11e53a0cf6fe4d021f634e2bbd181df69fcaf291856abeb9a1fb574acd7f432447338f0de4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31477e425246e424f470c11a91df8f69faa0eeccdd649e21c7f9f62f2cc2eb02603f0893b8073508f9e63990168b7cd5c6027af53bd5de067c9aab9f63e1dbfa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c6b02d798cf2f30613be3cb27dbca91c45dd07291a7784301ea7fa33d618526c47baa25c1ec6ba74e6ea2e76ebc43cf364842d5c2564f4ed5cabda9626c7ef3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 11:19:13.717606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:19:13.718030) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1504807091.188504-1285470128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 11:19:13.800495) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 11:19:13.800909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 11:19:13.801255) ========= ========= Total master_lag: 0.20 =========