builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-009 starttime: 1500589812.15 results: success (0) revision: 7d2e89fb92331d7e4296391213c1e63db628e046 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:12.146541) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:12.147018) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:12.147309) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:12.214448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:12.214761) ========= 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=17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-20 15:30:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.5M=0s 2017-07-20 15:30:12 (38.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126695 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:12.492531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:12.492932) ========= 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=17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017830 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:12.575129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:12.575570) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7d2e89fb92331d7e4296391213c1e63db628e046 --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 7d2e89fb92331d7e4296391213c1e63db628e046 --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=17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-20 15:30:12,611 truncating revision to first 12 chars 2017-07-20 15:30:12,611 Setting DEBUG logging. 2017-07-20 15:30:12,611 attempt 1/10 2017-07-20 15:30:12,611 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7d2e89fb9233?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-20 15:30:12,955 unpacking tar archive at: mozilla-central-7d2e89fb9233/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661369 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:13.296156) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:13.296483) ========= script_repo_revision: 7d2e89fb92331d7e4296391213c1e63db628e046 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:13.296869) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:13.297138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-20 15:30:13.312901) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-20 15:30:13.313289) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:30:13 INFO - MultiFileLogger online at 20170720 15:30:13 in /builds/slave/test 15:30:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:30:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:13 INFO - {'append_to_log': False, 15:30:13 INFO - 'base_work_dir': '/builds/slave/test', 15:30:13 INFO - 'blob_upload_branch': 'Firefox', 15:30:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:13 INFO - 'branch': 'Firefox', 15:30:13 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:13 INFO - 'code_coverage': False, 15:30:13 INFO - 'config_files': ('talos/linux_config.py',), 15:30:13 INFO - 'default_actions': ('clobber', 15:30:13 INFO - 'read-buildbot-config', 15:30:13 INFO - 'download-and-extract', 15:30:13 INFO - 'populate-webroot', 15:30:13 INFO - 'create-virtualenv', 15:30:13 INFO - 'install', 15:30:13 INFO - 'setup-mitmproxy', 15:30:13 INFO - 'run-tests'), 15:30:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:13 INFO - 'disable_ccov_upload': False, 15:30:13 INFO - 'download_minidump_stackwalk': True, 15:30:13 INFO - 'download_symbols': 'ondemand', 15:30:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:13 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:13 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:13 INFO - 'gecko_profile': False, 15:30:13 INFO - 'gecko_profile_interval': 0, 15:30:13 INFO - 'installer_path': 'installer.exe', 15:30:13 INFO - 'log_level': 'info', 15:30:13 INFO - 'log_name': 'talos', 15:30:13 INFO - 'log_to_console': True, 15:30:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:30:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:30:13 INFO - 'opt_config_files': (), 15:30:13 INFO - 'pip_index': False, 15:30:13 INFO - 'suite': 'dromaeojs-e10s', 15:30:13 INFO - 'system_bits': '32', 15:30:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:13 INFO - 'title': 'talos-linux64-ix-009', 15:30:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:13 INFO - 'use_talos_json': True, 15:30:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:13 INFO - 'work_dir': 'build'} 15:30:13 INFO - [mozharness: 2017-07-20 22:30:13.407258Z] Running clobber step. 15:30:13 INFO - Running pre-action listener: _resource_record_pre_action 15:30:13 INFO - Running main action method: clobber 15:30:13 INFO - rmtree: /builds/slave/test/build 15:30:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:30:14 INFO - Running post-action listener: _resource_record_post_action 15:30:14 INFO - [mozharness: 2017-07-20 22:30:14.452464Z] Finished clobber step (success) 15:30:14 INFO - [mozharness: 2017-07-20 22:30:14.452567Z] Running read-buildbot-config step. 15:30:14 INFO - Running pre-action listener: _resource_record_pre_action 15:30:14 INFO - Running main action method: read_buildbot_config 15:30:14 INFO - Using buildbot properties: 15:30:14 INFO - { 15:30:14 INFO - "project": "", 15:30:14 INFO - "product": "firefox", 15:30:14 INFO - "who": "ryanvm@gmail.com", 15:30:14 INFO - "installer_path": "public/build/target.tar.bz2", 15:30:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 15:30:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:30:14 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 15:30:14 INFO - "stage_platform": "linux64-stylo", 15:30:14 INFO - "basedir": "/builds/slave/test", 15:30:14 INFO - "buildnumber": 38, 15:30:14 INFO - "platform": "ubuntu64_hw_stylo", 15:30:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:30:14 INFO - "slavebuilddir": "test", 15:30:14 INFO - "taskId": "LWphdgClTnaZNKDxUlODoA", 15:30:14 INFO - "branch": "mozilla-central", 15:30:14 INFO - "script_repo_revision": "production", 15:30:14 INFO - "revision": "7d2e89fb92331d7e4296391213c1e63db628e046", 15:30:14 INFO - "slavename": "talos-linux64-ix-009", 15:30:14 INFO - "repo_path": "mozilla-central" 15:30:14 INFO - } 15:30:14 INFO - Finding installer, test and symbols from parent task. 15:30:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LWphdgClTnaZNKDxUlODoA'}, attempt #1 15:30:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LWphdgClTnaZNKDxUlODoA'}, attempt #1 15:30:15 INFO - Task dependencies: ZpE3yDenSu-6dRoKsALlaQ 15:30:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ'}, attempt #1 15:30:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.tar.bz2 15:30:15 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/test_packages.json 15:30:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.crashreporter-symbols.zip 15:30:15 INFO - Running post-action listener: _resource_record_post_action 15:30:15 INFO - [mozharness: 2017-07-20 22:30:15.794894Z] Finished read-buildbot-config step (success) 15:30:15 INFO - [mozharness: 2017-07-20 22:30:15.795114Z] Running download-and-extract step. 15:30:15 INFO - Running pre-action listener: _resource_record_pre_action 15:30:15 INFO - Running main action method: download_and_extract 15:30:15 INFO - mkdir: /builds/slave/test/build/tests 15:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:15 INFO - trying https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.test_packages.json 15:30:15 INFO - Downloading https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:30:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:30:16 INFO - Downloaded 989 bytes. 15:30:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:30:16 INFO - Using the following test package requirements: 15:30:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:30:16 INFO - u'common': [u'target.common.tests.zip'], 15:30:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:30:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:30:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:30:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:30:16 INFO - u'mozbase': [u'target.common.tests.zip'], 15:30:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:30:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:30:16 INFO - u'web-platform': [u'target.common.tests.zip', 15:30:16 INFO - u'target.web-platform.tests.tar.gz'], 15:30:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:30:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:30:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.common.tests.zip 15:30:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:30:16 INFO - Fetch https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.common.tests.zip into memory 15:30:17 INFO - Content-Length response header: 72766349 15:30:17 INFO - Bytes received: 72766349 15:30:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:30:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.common.tests.zip 15:30:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:30:28 INFO - Fetch https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.common.tests.zip into memory 15:30:29 INFO - Content-Length response header: 72766349 15:30:29 INFO - Bytes received: 72766349 15:30:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.talos.tests.zip 15:30:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:30:41 INFO - Fetch https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.talos.tests.zip into memory 15:30:42 INFO - Content-Length response header: 14498971 15:30:42 INFO - Bytes received: 14498971 15:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:42 INFO - trying https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.tar.bz2 15:30:42 INFO - Downloading https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:30:44 INFO - Downloaded 61910423 bytes. 15:30:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.tar.bz2 15:30:44 INFO - mkdir: /builds/slave/test/properties 15:30:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:30:44 INFO - Writing to file /builds/slave/test/properties/build_url 15:30:44 INFO - Contents: 15:30:44 INFO - build_url:https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.tar.bz2 15:30:44 INFO - Running post-action listener: _resource_record_post_action 15:30:44 INFO - Running post-action listener: set_extra_try_arguments 15:30:44 INFO - [mozharness: 2017-07-20 22:30:44.044296Z] Finished download-and-extract step (success) 15:30:44 INFO - [mozharness: 2017-07-20 22:30:44.044393Z] Running populate-webroot step. 15:30:44 INFO - Running pre-action listener: _resource_record_pre_action 15:30:44 INFO - Running main action method: populate_webroot 15:30:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:30:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:30:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:30:44 INFO - '--tppagecycles', 15:30:44 INFO - '7'], 15:30:44 INFO - 'tests': ['tsvgm']}}, 15:30:44 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:30:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:30:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:30:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:30:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:30:44 INFO - 'talos_options': ['--disable-e10s'], 15:30:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:30:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:30:44 INFO - 'talos_options': ['--disable-e10s'], 15:30:44 INFO - 'tests': ['damp', 'tps']}, 15:30:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:30:44 INFO - 'tests': ['damp', 'tps']}, 15:30:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:30:44 INFO - 'tests': ['dromaeo_dom']}, 15:30:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:30:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:30:44 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:30:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:30:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:30:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:30:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:30:44 INFO - 'tests': ['a11yr', 15:30:44 INFO - 'ts_paint', 15:30:44 INFO - 'tpaint', 15:30:44 INFO - 'sessionrestore', 15:30:44 INFO - 'sessionrestore_no_auto_restore', 15:30:44 INFO - 'tabpaint']}, 15:30:44 INFO - 'other-e10s': {'tests': ['a11yr', 15:30:44 INFO - 'ts_paint', 15:30:44 INFO - 'tpaint', 15:30:44 INFO - 'sessionrestore', 15:30:44 INFO - 'sessionrestore_many_windows', 15:30:44 INFO - 'sessionrestore_no_auto_restore', 15:30:44 INFO - 'tabpaint']}, 15:30:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:30:44 INFO - 'ts_paint', 15:30:44 INFO - 'tpaint', 15:30:44 INFO - 'sessionrestore', 15:30:44 INFO - 'sessionrestore_many_windows', 15:30:44 INFO - 'sessionrestore_no_auto_restore', 15:30:44 INFO - 'tabpaint']}, 15:30:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:30:44 INFO - 'ts_paint', 15:30:44 INFO - 'tpaint', 15:30:44 INFO - 'sessionrestore', 15:30:44 INFO - 'sessionrestore_many_windows', 15:30:44 INFO - 'sessionrestore_no_auto_restore', 15:30:44 INFO - 'tabpaint']}, 15:30:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:30:44 INFO - 'tests': ['a11yr', 15:30:44 INFO - 'ts_paint', 15:30:44 INFO - 'tpaint', 15:30:44 INFO - 'sessionrestore', 15:30:44 INFO - 'sessionrestore_no_auto_restore', 15:30:44 INFO - 'tabpaint']}, 15:30:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:30:44 INFO - 'tests': ['a11yr', 15:30:44 INFO - 'ts_paint', 15:30:44 INFO - 'tpaint', 15:30:44 INFO - 'sessionrestore', 15:30:44 INFO - 'sessionrestore_no_auto_restore', 15:30:44 INFO - 'tabpaint']}, 15:30:44 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 15:30:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:30:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:30:44 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:30:44 INFO - 'talos_options': ['--mitmproxy', 15:30:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:30:44 INFO - '--firstNonBlankPaint'], 15:30:44 INFO - 'tests': ['quantum_pageload_google', 15:30:44 INFO - 'quantum_pageload_youtube', 15:30:44 INFO - 'quantum_pageload_amazon', 15:30:44 INFO - 'quantum_pageload_facebook']}, 15:30:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:30:44 INFO - 'tests': ['tsvgx', 15:30:44 INFO - 'tsvgr_opacity', 15:30:44 INFO - 'tart', 15:30:44 INFO - 'tscrollx', 15:30:44 INFO - 'cart', 15:30:44 INFO - 'tsvg_static']}, 15:30:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:30:44 INFO - 'tsvgr_opacity', 15:30:44 INFO - 'tart', 15:30:44 INFO - 'tscrollx', 15:30:44 INFO - 'cart', 15:30:44 INFO - 'tsvg_static']}, 15:30:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:30:44 INFO - 'talos_options': ['--disable-e10s'], 15:30:44 INFO - 'tests': ['tp5o']}, 15:30:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:30:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:30:44 INFO - 'talos_options': ['--disable-e10s', 15:30:44 INFO - '--xperf_path', 15:30:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:44 INFO - 'tests': ['tp5n']}, 15:30:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:30:44 INFO - 'talos_options': ['--xperf_path', 15:30:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:44 INFO - 'tests': ['tp5n']}}, 15:30:44 INFO - 'talos.zip': {'path': '', 15:30:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:30:44 INFO - Running post-action listener: _resource_record_post_action 15:30:44 INFO - [mozharness: 2017-07-20 22:30:44.059604Z] Finished populate-webroot step (success) 15:30:44 INFO - [mozharness: 2017-07-20 22:30:44.059694Z] Running create-virtualenv step. 15:30:44 INFO - Running pre-action listener: _resource_record_pre_action 15:30:44 INFO - Running main action method: create_virtualenv 15:30:44 INFO - Creating virtualenv /builds/slave/test/build/venv 15:30:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:30:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:30:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:30:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:30:44 INFO - Using real prefix '/usr' 15:30:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:30:44 INFO - Installing distribute.............................................................................................................................................................................................done. 15:30:46 INFO - Installing pip.................done. 15:30:46 INFO - Return code: 0 15:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:30:46 INFO - Reading from file tmpfile_stdout 15:30:46 INFO - Output received: 15:30:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:30:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:46 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 0xa551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3d00>, '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 0xdc4c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc5090>, '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': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:30:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:30:46 INFO - Using env: {'DISPLAY': ':0', 15:30:46 INFO - 'HOME': '/home/cltbld', 15:30:46 INFO - 'LANG': 'en_US.UTF-8', 15:30:46 INFO - 'LANGUAGE': 'en_US:en', 15:30:46 INFO - 'LOGNAME': 'cltbld', 15:30:46 INFO - 'MAIL': '/var/mail/cltbld', 15:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:46 INFO - 'MOZ_NO_REMOTE': '1', 15:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:46 INFO - 'NO_EM_RESTART': '1', 15:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:46 INFO - 'PWD': '/builds/slave/test', 15:30:46 INFO - 'SHELL': '/bin/bash', 15:30:46 INFO - 'SHLVL': '1', 15:30:46 INFO - 'TERM': 'linux', 15:30:46 INFO - 'TMOUT': '86400', 15:30:46 INFO - 'USER': 'cltbld', 15:30:46 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 15:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:46 INFO - '_': '/tools/buildbot/bin/python'} 15:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:30:47 INFO - Cleaning up... 15:30:47 INFO - Return code: 0 15:30:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3d00>, '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 0xdc4c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc5090>, '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': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:30:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:30:47 INFO - Using env: {'DISPLAY': ':0', 15:30:47 INFO - 'HOME': '/home/cltbld', 15:30:47 INFO - 'LANG': 'en_US.UTF-8', 15:30:47 INFO - 'LANGUAGE': 'en_US:en', 15:30:47 INFO - 'LOGNAME': 'cltbld', 15:30:47 INFO - 'MAIL': '/var/mail/cltbld', 15:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:47 INFO - 'MOZ_NO_REMOTE': '1', 15:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:47 INFO - 'NO_EM_RESTART': '1', 15:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:47 INFO - 'PWD': '/builds/slave/test', 15:30:47 INFO - 'SHELL': '/bin/bash', 15:30:47 INFO - 'SHLVL': '1', 15:30:47 INFO - 'TERM': 'linux', 15:30:47 INFO - 'TMOUT': '86400', 15:30:47 INFO - 'USER': 'cltbld', 15:30:47 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 15:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:47 INFO - '_': '/tools/buildbot/bin/python'} 15:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:47 INFO - Downloading/unpacking psutil>=3.1.1 15:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:30:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:30:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:30:48 INFO - Installing collected packages: psutil 15:30:48 INFO - Running setup.py install for psutil 15:30:48 INFO - building 'psutil._psutil_linux' extension 15:30:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:30:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:30:48 INFO - building 'psutil._psutil_posix' extension 15:30:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:30:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:30:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:30:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:30:48 INFO - Successfully installed psutil 15:30:48 INFO - Cleaning up... 15:30:49 INFO - Return code: 0 15:30:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:49 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 0xa551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3d00>, '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 0xdc4c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc5090>, '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': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:30:49 INFO - Using env: {'DISPLAY': ':0', 15:30:49 INFO - 'HOME': '/home/cltbld', 15:30:49 INFO - 'LANG': 'en_US.UTF-8', 15:30:49 INFO - 'LANGUAGE': 'en_US:en', 15:30:49 INFO - 'LOGNAME': 'cltbld', 15:30:49 INFO - 'MAIL': '/var/mail/cltbld', 15:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:49 INFO - 'MOZ_NO_REMOTE': '1', 15:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:49 INFO - 'NO_EM_RESTART': '1', 15:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:49 INFO - 'PWD': '/builds/slave/test', 15:30:49 INFO - 'SHELL': '/bin/bash', 15:30:49 INFO - 'SHLVL': '1', 15:30:49 INFO - 'TERM': 'linux', 15:30:49 INFO - 'TMOUT': '86400', 15:30:49 INFO - 'USER': 'cltbld', 15:30:49 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 15:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:49 INFO - '_': '/tools/buildbot/bin/python'} 15:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:30:50 INFO - Installing collected packages: mozsystemmonitor 15:30:50 INFO - Running setup.py install for mozsystemmonitor 15:30:50 INFO - Successfully installed mozsystemmonitor 15:30:50 INFO - Cleaning up... 15:30:50 INFO - Return code: 0 15:30:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:50 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 0xa551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3d00>, '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 0xdc4c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc5090>, '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': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:30:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:30:50 INFO - Using env: {'DISPLAY': ':0', 15:30:50 INFO - 'HOME': '/home/cltbld', 15:30:50 INFO - 'LANG': 'en_US.UTF-8', 15:30:50 INFO - 'LANGUAGE': 'en_US:en', 15:30:50 INFO - 'LOGNAME': 'cltbld', 15:30:50 INFO - 'MAIL': '/var/mail/cltbld', 15:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:50 INFO - 'MOZ_NO_REMOTE': '1', 15:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:50 INFO - 'NO_EM_RESTART': '1', 15:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:50 INFO - 'PWD': '/builds/slave/test', 15:30:50 INFO - 'SHELL': '/bin/bash', 15:30:50 INFO - 'SHLVL': '1', 15:30:50 INFO - 'TERM': 'linux', 15:30:50 INFO - 'TMOUT': '86400', 15:30:50 INFO - 'USER': 'cltbld', 15:30:50 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 15:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:50 INFO - '_': '/tools/buildbot/bin/python'} 15:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:50 INFO - Downloading/unpacking jsonschema==2.5.1 15:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:30:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:51 INFO - Downloading functools32-3.2.3-2.tar.gz 15:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:30:51 INFO - warning: no files found matching '*.txt' 15:30:51 INFO - no previously-included directories found matching 'build' 15:30:51 INFO - no previously-included directories found matching 'dist' 15:30:51 INFO - no previously-included directories found matching '.git*' 15:30:51 INFO - Installing collected packages: jsonschema, functools32 15:30:52 INFO - Running setup.py install for functools32 15:30:52 INFO - warning: no files found matching '*.txt' 15:30:52 INFO - no previously-included directories found matching 'build' 15:30:52 INFO - no previously-included directories found matching 'dist' 15:30:52 INFO - no previously-included directories found matching '.git*' 15:30:52 INFO - Successfully installed jsonschema functools32 15:30:52 INFO - Cleaning up... 15:30:52 INFO - Return code: 0 15:30:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3d00>, '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 0xdc4c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc5090>, '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': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:30:52 INFO - Using env: {'DISPLAY': ':0', 15:30:52 INFO - 'HOME': '/home/cltbld', 15:30:52 INFO - 'LANG': 'en_US.UTF-8', 15:30:52 INFO - 'LANGUAGE': 'en_US:en', 15:30:52 INFO - 'LOGNAME': 'cltbld', 15:30:52 INFO - 'MAIL': '/var/mail/cltbld', 15:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:52 INFO - 'MOZ_NO_REMOTE': '1', 15:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:52 INFO - 'NO_EM_RESTART': '1', 15:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:52 INFO - 'PWD': '/builds/slave/test', 15:30:52 INFO - 'SHELL': '/bin/bash', 15:30:52 INFO - 'SHLVL': '1', 15:30:52 INFO - 'TERM': 'linux', 15:30:52 INFO - 'TMOUT': '86400', 15:30:52 INFO - 'USER': 'cltbld', 15:30:52 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 15:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:52 INFO - '_': '/tools/buildbot/bin/python'} 15:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:30:52 INFO - Cleaning up... 15:30:52 INFO - Return code: 0 15:30:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3d00>, '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 0xdc4c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc5090>, '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': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:30:52 INFO - Using env: {'DISPLAY': ':0', 15:30:52 INFO - 'HOME': '/home/cltbld', 15:30:52 INFO - 'LANG': 'en_US.UTF-8', 15:30:52 INFO - 'LANGUAGE': 'en_US:en', 15:30:52 INFO - 'LOGNAME': 'cltbld', 15:30:52 INFO - 'MAIL': '/var/mail/cltbld', 15:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:52 INFO - 'MOZ_NO_REMOTE': '1', 15:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:52 INFO - 'NO_EM_RESTART': '1', 15:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:52 INFO - 'PWD': '/builds/slave/test', 15:30:52 INFO - 'SHELL': '/bin/bash', 15:30:52 INFO - 'SHLVL': '1', 15:30:52 INFO - 'TERM': 'linux', 15:30:52 INFO - 'TMOUT': '86400', 15:30:52 INFO - 'USER': 'cltbld', 15:30:52 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 15:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:52 INFO - '_': '/tools/buildbot/bin/python'} 15:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:52 INFO - Downloading/unpacking blobuploader==1.2.4 15:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:53 INFO - Downloading blobuploader-1.2.4.tar.gz 15:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:30:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:30:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:54 INFO - Downloading docopt-0.6.1.tar.gz 15:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:30:54 INFO - Installing collected packages: blobuploader, requests, docopt 15:30:54 INFO - Running setup.py install for blobuploader 15:30:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:30:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:30:54 INFO - Running setup.py install for requests 15:30:54 INFO - Running setup.py install for docopt 15:30:55 INFO - Successfully installed blobuploader requests docopt 15:30:55 INFO - Cleaning up... 15:30:55 INFO - Return code: 0 15:30:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:30: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')]} 15:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30: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')]} 15:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:55 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 0xa551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3d00>, '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 0xdc4c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc5090>, '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': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:30:55 INFO - Using env: {'DISPLAY': ':0', 15:30:55 INFO - 'HOME': '/home/cltbld', 15:30:55 INFO - 'LANG': 'en_US.UTF-8', 15:30:55 INFO - 'LANGUAGE': 'en_US:en', 15:30:55 INFO - 'LOGNAME': 'cltbld', 15:30:55 INFO - 'MAIL': '/var/mail/cltbld', 15:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:55 INFO - 'MOZ_NO_REMOTE': '1', 15:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:55 INFO - 'NO_EM_RESTART': '1', 15:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:55 INFO - 'PWD': '/builds/slave/test', 15:30:55 INFO - 'SHELL': '/bin/bash', 15:30:55 INFO - 'SHLVL': '1', 15:30:55 INFO - 'TERM': 'linux', 15:30:55 INFO - 'TMOUT': '86400', 15:30:55 INFO - 'USER': 'cltbld', 15:30:55 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 15:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:55 INFO - '_': '/tools/buildbot/bin/python'} 15:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:30:55 INFO - Running setup.py (path:/tmp/pip-YJHfdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:30:55 INFO - Running setup.py (path:/tmp/pip-yjue6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:30:55 INFO - Running setup.py (path:/tmp/pip-YenTJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:30:55 INFO - Running setup.py (path:/tmp/pip-bQzcUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:30:55 INFO - Running setup.py (path:/tmp/pip-pMeC9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:30:55 INFO - Running setup.py (path:/tmp/pip-WUv8CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:30:55 INFO - Running setup.py (path:/tmp/pip-Ku4era-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:30:55 INFO - Running setup.py (path:/tmp/pip-7DRyBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:30:55 INFO - Running setup.py (path:/tmp/pip-F36fjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:30:55 INFO - Running setup.py (path:/tmp/pip-DM5NXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:30:55 INFO - Running setup.py (path:/tmp/pip-q0BtEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:30:56 INFO - Running setup.py (path:/tmp/pip-FIDhMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:30:56 INFO - Running setup.py (path:/tmp/pip-oXS1rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:30:56 INFO - Running setup.py (path:/tmp/pip-ipXJOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:56 INFO - Running setup.py (path:/tmp/pip-_fbpYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:30:56 INFO - Running setup.py (path:/tmp/pip-65tsGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:30:56 INFO - Running setup.py (path:/tmp/pip-cbQLAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:30:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:30:56 INFO - Running setup.py install for manifestparser 15:30:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:30:56 INFO - Running setup.py install for mozcrash 15:30:56 INFO - Running setup.py install for mozdebug 15:30:56 INFO - Running setup.py install for mozdevice 15:30:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:30:56 INFO - Running setup.py install for mozfile 15:30:57 INFO - Running setup.py install for mozhttpd 15:30:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:30:57 INFO - Running setup.py install for mozinfo 15:30:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:30:57 INFO - Running setup.py install for mozInstall 15:30:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:30:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:30:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:30:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:30:57 INFO - Running setup.py install for mozleak 15:30:57 INFO - Running setup.py install for mozlog 15:30:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:30:57 INFO - Running setup.py install for moznetwork 15:30:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:30:57 INFO - Running setup.py install for mozprocess 15:30:57 INFO - Running setup.py install for mozprofile 15:30:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:30:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:30:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:30:57 INFO - Running setup.py install for mozrunner 15:30:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:30:57 INFO - Running setup.py install for mozscreenshot 15:30:58 INFO - Running setup.py install for moztest 15:30:58 INFO - Running setup.py install for mozversion 15:30:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:30:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:30:58 INFO - Cleaning up... 15:30:58 INFO - Return code: 0 15:30:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:30: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')]} 15:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30: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')]} 15:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:58 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 0xa551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3d00>, '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 0xdc4c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc5090>, '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': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:30:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:30:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:30:58 INFO - Using env: {'DISPLAY': ':0', 15:30:58 INFO - 'HOME': '/home/cltbld', 15:30:58 INFO - 'LANG': 'en_US.UTF-8', 15:30:58 INFO - 'LANGUAGE': 'en_US:en', 15:30:58 INFO - 'LOGNAME': 'cltbld', 15:30:58 INFO - 'MAIL': '/var/mail/cltbld', 15:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:58 INFO - 'MOZ_NO_REMOTE': '1', 15:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:58 INFO - 'NO_EM_RESTART': '1', 15:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:58 INFO - 'PWD': '/builds/slave/test', 15:30:58 INFO - 'SHELL': '/bin/bash', 15:30:58 INFO - 'SHLVL': '1', 15:30:58 INFO - 'TERM': 'linux', 15:30:58 INFO - 'TMOUT': '86400', 15:30:58 INFO - 'USER': 'cltbld', 15:30:58 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 15:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:58 INFO - '_': '/tools/buildbot/bin/python'} 15:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:30:58 INFO - Running setup.py (path:/tmp/pip-dXUzJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:30:58 INFO - Running setup.py (path:/tmp/pip-k0zZCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:30:58 INFO - Running setup.py (path:/tmp/pip-GnicNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:30:58 INFO - Running setup.py (path:/tmp/pip-Wztehr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:30:58 INFO - Running setup.py (path:/tmp/pip-Aw51YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:30:58 INFO - Running setup.py (path:/tmp/pip-bpW2k2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:30:58 INFO - Running setup.py (path:/tmp/pip-IvUU6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:30:59 INFO - Running setup.py (path:/tmp/pip-sSPyCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:30:59 INFO - Running setup.py (path:/tmp/pip-djM7Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:30:59 INFO - Running setup.py (path:/tmp/pip-9D3404-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:30:59 INFO - Running setup.py (path:/tmp/pip-YG7IIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:30:59 INFO - Running setup.py (path:/tmp/pip-UbIjr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:30:59 INFO - Running setup.py (path:/tmp/pip-a_UUeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:30:59 INFO - Running setup.py (path:/tmp/pip-WPMH37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:59 INFO - Running setup.py (path:/tmp/pip-iPlent-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:30:59 INFO - Running setup.py (path:/tmp/pip-qnTTNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:30:59 INFO - Running setup.py (path:/tmp/pip-XuBNon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:30:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:30: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 15:30: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 15:30: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 15:30: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 15:31:00 INFO - Downloading blessings-1.6.tar.gz 15:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:00 INFO - Installing collected packages: blessings 15:31:00 INFO - Running setup.py install for blessings 15:31:01 INFO - Successfully installed blessings 15:31:01 INFO - Cleaning up... 15:31:01 INFO - Return code: 0 15:31:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:31:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:01 INFO - Reading from file tmpfile_stdout 15:31:01 INFO - Current package versions: 15:31:01 INFO - argparse == 1.2.1 15:31:01 INFO - blessings == 1.6 15:31:01 INFO - blobuploader == 1.2.4 15:31:01 INFO - docopt == 0.6.1 15:31:01 INFO - functools32 == 3.2.3-2 15:31:01 INFO - jsonschema == 2.5.1 15:31:01 INFO - manifestparser == 1.1 15:31:01 INFO - mozInstall == 1.13 15:31:01 INFO - mozcrash == 1.0 15:31:01 INFO - mozdebug == 0.1 15:31:01 INFO - mozdevice == 0.51 15:31:01 INFO - mozfile == 1.2 15:31:01 INFO - mozhttpd == 0.7 15:31:01 INFO - mozinfo == 0.10 15:31:01 INFO - mozleak == 0.1 15:31:01 INFO - mozlog == 3.5 15:31:01 INFO - moznetwork == 0.27 15:31:01 INFO - mozprocess == 0.25 15:31:01 INFO - mozprofile == 0.28 15:31:01 INFO - mozrunner == 6.13 15:31:01 INFO - mozscreenshot == 0.1 15:31:01 INFO - mozsystemmonitor == 0.3 15:31:01 INFO - moztest == 0.8 15:31:01 INFO - mozversion == 1.4 15:31:01 INFO - psutil == 3.1.1 15:31:01 INFO - requests == 1.2.3 15:31:01 INFO - wsgiref == 0.1.2 15:31:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31: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')]} 15:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:01 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 0xa551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3d00>, '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 0xdc4c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc5090>, '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': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:31:01 INFO - Using env: {'DISPLAY': ':0', 15:31:01 INFO - 'HOME': '/home/cltbld', 15:31:01 INFO - 'LANG': 'en_US.UTF-8', 15:31:01 INFO - 'LANGUAGE': 'en_US:en', 15:31:01 INFO - 'LOGNAME': 'cltbld', 15:31:01 INFO - 'MAIL': '/var/mail/cltbld', 15:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:01 INFO - 'MOZ_NO_REMOTE': '1', 15:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:01 INFO - 'NO_EM_RESTART': '1', 15:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:01 INFO - 'PWD': '/builds/slave/test', 15:31:01 INFO - 'SHELL': '/bin/bash', 15:31:01 INFO - 'SHLVL': '1', 15:31:01 INFO - 'TERM': 'linux', 15:31:01 INFO - 'TMOUT': '86400', 15:31:01 INFO - 'USER': 'cltbld', 15:31:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 15:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:01 INFO - '_': '/tools/buildbot/bin/python'} 15:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:31:01 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:31: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 15:31: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 15:31: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 15:31: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 15:31:02 INFO - Downloading marionette_driver-1.4.0.tar.gz 15:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 15:31:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 15:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:31:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:31:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:31:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:31:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:31:02 INFO - Installing collected packages: marionette-driver, simplejson 15:31:02 INFO - Running setup.py install for marionette-driver 15:31:03 INFO - Running setup.py install for simplejson 15:31:03 INFO - building 'simplejson._speedups' extension 15:31:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:31:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:31:04 INFO - Successfully installed marionette-driver simplejson 15:31:04 INFO - Cleaning up... 15:31:04 INFO - Return code: 0 15:31:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31: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')]} 15:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:04 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 0xa551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc21a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3d00>, '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 0xdc4c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc5090>, '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': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:31:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:31:04 INFO - Using env: {'DISPLAY': ':0', 15:31:04 INFO - 'HOME': '/home/cltbld', 15:31:04 INFO - 'LANG': 'en_US.UTF-8', 15:31:04 INFO - 'LANGUAGE': 'en_US:en', 15:31:04 INFO - 'LOGNAME': 'cltbld', 15:31:04 INFO - 'MAIL': '/var/mail/cltbld', 15:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:04 INFO - 'MOZ_NO_REMOTE': '1', 15:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:04 INFO - 'NO_EM_RESTART': '1', 15:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:04 INFO - 'PWD': '/builds/slave/test', 15:31:04 INFO - 'SHELL': '/bin/bash', 15:31:04 INFO - 'SHLVL': '1', 15:31:04 INFO - 'TERM': 'linux', 15:31:04 INFO - 'TMOUT': '86400', 15:31:04 INFO - 'USER': 'cltbld', 15:31:04 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 15:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:04 INFO - '_': '/tools/buildbot/bin/python'} 15:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:31:04 INFO - Cleaning up... 15:31:04 INFO - Return code: 0 15:31:04 INFO - Running post-action listener: _resource_record_post_action 15:31:04 INFO - Running post-action listener: _start_resource_monitoring 15:31:04 INFO - Starting resource monitoring. 15:31:04 INFO - [mozharness: 2017-07-20 22:31:04.346781Z] Finished create-virtualenv step (success) 15:31:04 INFO - [mozharness: 2017-07-20 22:31:04.347297Z] Running install step. 15:31:04 INFO - Running pre-action listener: _resource_record_pre_action 15:31:04 INFO - Running main action method: install 15:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:04 INFO - Reading from file tmpfile_stdout 15:31:04 INFO - Detecting whether we're running mozinstall >=1.0... 15:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:31:04 INFO - Reading from file tmpfile_stdout 15:31:04 INFO - Output received: 15:31:04 INFO - Usage: mozinstall [options] installer 15:31:04 INFO - Options: 15:31:04 INFO - -h, --help show this help message and exit 15:31:04 INFO - -d DEST, --destination=DEST 15:31:04 INFO - Directory to install application into. [default: 15:31:04 INFO - "/builds/slave/test"] 15:31:04 INFO - --app=APP Application being installed. [default: firefox] 15:31:04 INFO - mkdir: /builds/slave/test/build/application 15:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:31:22 INFO - Reading from file tmpfile_stdout 15:31:22 INFO - Output received: 15:31:22 INFO - /builds/slave/test/build/application/firefox/firefox 15:31:22 INFO - Running post-action listener: _resource_record_post_action 15:31:22 INFO - [mozharness: 2017-07-20 22:31:22.624085Z] Finished install step (success) 15:31:22 INFO - [mozharness: 2017-07-20 22:31:22.624338Z] Running setup-mitmproxy step. 15:31:22 INFO - Running pre-action listener: _resource_record_pre_action 15:31:22 INFO - Running main action method: setup_mitmproxy 15:31:22 INFO - Skipping: mitmproxy is not required 15:31:22 INFO - Running post-action listener: _resource_record_post_action 15:31:22 INFO - [mozharness: 2017-07-20 22:31:22.625512Z] Finished setup-mitmproxy step (success) 15:31:22 INFO - [mozharness: 2017-07-20 22:31:22.625753Z] Running run-tests step. 15:31:22 INFO - Running pre-action listener: _resource_record_pre_action 15:31:22 INFO - Running pre-action listener: _set_gcov_prefix 15:31:22 INFO - Running main action method: run_tests 15:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:31:22 INFO - Python 2.7.3 15:31:22 INFO - Return code: 0 15:31:22 INFO - grabbing minidump binary from tooltool 15:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0xdc3d00>, '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 0xdc4c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc5090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:31:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:31:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:31:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:31:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:31:22 INFO - Return code: 0 15:31:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:31:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:31:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:31:22 INFO - ENV: RUST_BACKTRACE is now 1 15:31:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:31:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:31:22 INFO - Using env: {'DISPLAY': ':0', 15:31:22 INFO - 'HOME': '/home/cltbld', 15:31:22 INFO - 'LANG': 'en_US.UTF-8', 15:31:22 INFO - 'LANGUAGE': 'en_US:en', 15:31:22 INFO - 'LOGNAME': 'cltbld', 15:31:22 INFO - 'MAIL': '/var/mail/cltbld', 15:31:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:31:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:22 INFO - 'MOZ_NO_REMOTE': '1', 15:31:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:22 INFO - 'NO_EM_RESTART': '1', 15:31:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:22 INFO - 'PWD': '/builds/slave/test', 15:31:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:31:22 INFO - 'RUST_BACKTRACE': '1', 15:31:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:31:22 INFO - 'SHELL': '/bin/bash', 15:31:22 INFO - 'SHLVL': '1', 15:31:22 INFO - 'TERM': 'linux', 15:31:22 INFO - 'TMOUT': '86400', 15:31:22 INFO - 'USER': 'cltbld', 15:31:22 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511', 15:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:22 INFO - '_': '/tools/buildbot/bin/python'} 15:31:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:31:23 INFO - mozversion application_buildid: 20170720215118 15:31:23 INFO - mozversion application_changeset: 7d2e89fb92331d7e4296391213c1e63db628e046 15:31:23 INFO - mozversion application_display_name: Nightly 15:31:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:31:23 INFO - mozversion application_name: Firefox 15:31:23 INFO - mozversion application_remotingname: firefox 15:31:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:31:23 INFO - mozversion application_vendor: Mozilla 15:31:23 INFO - mozversion application_version: 56.0a1 15:31:23 INFO - mozversion platform_buildid: 20170720215118 15:31:23 INFO - mozversion platform_changeset: 7d2e89fb92331d7e4296391213c1e63db628e046 15:31:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:31:23 INFO - mozversion platform_version: 56.0a1 15:31:23 INFO - using testdate: 1500589883 15:31:23 INFO - actual date: 1500589883 15:31:23 INFO - starting webserver on 'localhost:42924' 15:31:23 INFO - SUITE-START | Running 2 tests 15:31:23 INFO - TEST-START | dromaeo_css 15:31:23 INFO - Initialising browser for dromaeo_css test... 15:31:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42924/getInfo.html -profile /tmp/tmpHsu0aj/profile 15:31:23 INFO - TEST-INFO | started process 20114 (/builds/slave/test/build/application/firefox/firefox http://localhost:42924/getInfo.html) 15:31:29 INFO - TEST-INFO | 20114: exit 0 15:31:29 INFO - Browser initialized. 15:31:29 INFO - Running cycle 1/1 for dromaeo_css test... 15:31:29 INFO - TEST-INFO | started process 20344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHsu0aj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:41 INFO - PID 20344 | RSS: Main: 175165440 15:31:41 INFO - PID 20344 | 15:34:40 INFO - PID 20344 | Cycle 1(1): loaded http://localhost:42924/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42924/tests/dromaeo/cssquery-ext.html) 15:34:41 INFO - PID 20344 | RSS: Main: 180068352 15:34:41 INFO - PID 20344 | 15:37:43 INFO - PID 20344 | Cycle 1(1): loaded http://localhost:42924/tests/dromaeo/cssquery-ext.html (next: http://localhost:42924/tests/dromaeo/cssquery-jquery.html) 15:37:44 INFO - PID 20344 | RSS: Main: 178712576 15:37:44 INFO - PID 20344 | 15:40:46 INFO - PID 20344 | Cycle 1(1): loaded http://localhost:42924/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42924/tests/dromaeo/cssquery-mootools.html) 15:40:46 INFO - PID 20344 | RSS: Main: 180297728 15:40:46 INFO - PID 20344 | 15:43:48 INFO - PID 20344 | Cycle 1(1): loaded http://localhost:42924/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42924/tests/dromaeo/cssquery-prototype.html) 15:43:49 INFO - PID 20344 | RSS: Main: 179310592 15:43:49 INFO - PID 20344 | 15:46:53 INFO - PID 20344 | Cycle 1(1): loaded http://localhost:42924/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42924/tests/dromaeo/cssquery-yui.html) 15:46:53 INFO - PID 20344 | RSS: Main: 180781056 15:46:53 INFO - PID 20344 | 15:49:55 INFO - PID 20344 | Cycle 1(1): loaded http://localhost:42924/tests/dromaeo/cssquery-yui.html (next: http://localhost:42924/tests/dromaeo/cssquery-dojo.html) 15:49:56 INFO - PID 20344 | RSS: Main: 182505472 15:49:56 INFO - PID 20344 | 15:49:56 INFO - PID 20344 | __start_tp_report 15:49:56 INFO - PID 20344 | _x_x_mozilla_page_load 15:49:56 INFO - PID 20344 | _x_x_mozilla_page_load_details 15:49:56 INFO - PID 20344 | |i|pagename|runs| 15:49:56 INFO - PID 20344 | |0;dojo.html;3018.185090025693;3070.140360699004;3078.492048811946;3101.286704058067;3108.254019035432;5950.940490595092;5959.165716799652;5982.982892908205;6011.519078473717;6103.26760788706;6026.2165918430655;6078.969605151968;6108.358622344656;6133.1413602095745;6136.938630613692;5408.594355423339;5504.311961004874;5510.779568817243;5554.472325129126;5624.493795558399;5414.648047876895;5492.725363731797;5502.174673798922;5576.665400075988;5577.52591029761;5501.862453438676;5559.916601250964;5573.247611572447;5582.023145949463;5591.580631452616;5433.212184233264;5491.643043202219;5521.834344969658;5562.666240025612;5585.469380408855;5434.864128396782;5457.808976685837;5519.834404967857;5522.806701765459;5533.335999680024;5899.675517846516;5938.7624495020145;5982.04287314032;6011.4289142531825;6025.638461692312;6341.524385671093;6434.549581529295;6443.710033048524;6501.707423165969;6519.93480065198;6472.773452929125;6504.609723416563;6554.3117972613145;6554.967225163891;6579.013148027786;5982.641041537521;5986.461218490357;6057.909131362989;6077.726502307407;6078.057901025348;6509.641969691713;6567.244766851778;6637.966810165918;6670.232923213893;6688.36460536258;6288.213973253343;6307.5584709070845;6308.716107775161;6310.337414571496;6314.968425157845;6368.554201205871;6495.220573531206;6503.122078519434;6529.771457998947;6543.901841472381;6409.935900641027;6430.935690643034;6454.709538070798;6486.870262594722;6489.7404103835315;6440.516961227833;6445.2587952386075;6533.869322613521;6540.215174179129;6544.476441884733;5146.150885103991;5162.767675454614;5219.321488206585;5236.528712415901;5243.528082472596;4538.387317712067;4547.3179023146795;4587.311903214544;4587.839425620087;4620.491745907947;5598.384177740445;5604.6917419542315;5610;5681.346645135863;5686.943130568724;6304.306526282106;6461.773837915651;6498.122753428322;6514.4462720668325;6554.8361290968105;5591.9720401398545;5636.887262254732;5642.520385767256;5648;5651.660900345993;5693.572982026281;5739.885202295931;5741.7990370337675;5770.567207459458;5776.480116789425;6157.876842463036;6229.501639868799;6244.812655620339;6315.305316415191;6331.68341582919;6308.684565771785;6458.289588145394;6459.321771213955;6550;6551.574147680385;6312.621242725451;6328.082428047999;6330.8100756977365;6349.238091429058;6365.61806291624;6330.8100756977365;6362.554621176473;6370.044493326038;6449.806505804833;6450.322716114741;6420.133282006869;6482.222133344029;6501.317361676955;6589.374009469285;6596.80209593713;6278.497720182466;6289.7484100635465;6355;6357.396047375492;6370.872582548416;6259.718312676032;6267.185265915402;6342;6354.142190804368;6356.77751278703;6110.1445797587485;6171.074338849208;6192.287886893065;6204.193454850841;6206.906896396648;6290.119383286435;6320.936790632219;6360.77737279193;6415.06981487691;6418.358164183544;6120.724567394389;6138.294096178996;6152.200213972155;6235.75056997715;6236.875262494816 15:49:56 INFO - PID 20344 | |1;ext.html;780.9375249979998;825.3438516379478;847.9660813567458;872.3588162700418;872.4765140915451;40088.59911400885;41093.79453102738;41111.38332925005;41154;41217.7939110304;36974.445383319275;37344;37350.8132459338;37535.62464375355;37605.43591846125;6789.864202715955;6849.07537482441;6889.7588584399555;6910.619915904624;6911.861762764742;6794.558353706993;6878.587284762905;6890.586564806128;6894.24163342032;6894.689738961733;6861.691223894937;7470.178280389153;7636.961815190916;7649.502782319159;7658.234176582353;7568.508046976929;7620.885686714703;7627.313541781211;7628.694852205933;7634.351080158193;7456.701731930716;7490.6629201686055;7546.396288296923;7562.470627056108;7567.962160189164;37735.24529509422;37889.43165852514;37975.810120949216;38224;38301.0849457526;3553.1650062235353;3600.5859326177565;3613.2050948791225;3618.5115009473648;3621.619729928372;30013.699863001308;30032.24919377033;30070.54894176589;30119.548206776915;30132.69867301321;4902.632302577321;4922.409310882681;4950.777215025332;4951.480094590052;4980.750962451899;189559;190404;191521;195843;205710.9714451433;48623;48784.7560762201;48825.267620985716;48962;48979;49932.750336248086;50359.49640503621;50420.49579504158;50424.747876260386;50646;16198.676026479405;16347.34610615562;16374.508764737076;16386.180690965404;16505.33978640865;13669.931650341685;13682.589522314347;13691.726165476834;13702.52041178554;13711;14243.359048842827;14401.207933563755;14421.567352979428;14612.123272603678;14630.122192668474;5615.354234263112;5713.143028545752;5816.883662326814;5846.94153058464;5904.852378690567;987.4075554667143;992.980140397188;1007.9395236285847;1016.3089099412323;1026.753290684601;22344.888275558842;22553.77446225517;22653.320400388016;22958.96684649195;23284.185053523044;1082.929609575391;1104.5802595014004;1110.9388983605818;1111.338753441717;1131.8754936956927;11464;12089;12100.700866835274;12155.696107597381;12249.69375765613;223341;224408;225386;225680;225939;52002;52131.73934130305;52263.47736522662;52319;52606.47393526016;1458.6572155543438;1476.8375478697335;1494.7010597880467;1500.4523348977546;1505.8193016837831;22307.77692223057;22418.66372004454;22591.887040564692;22940.655890161994;23235;37599.624003759614;37688.869333920025;37792.055198620255;37816.43275350817;37819;192920;209391;211882;211952;213149;30556.694433056273;30848.537271941386;31117.688823112385;33394.33211335808;35737.1065723359;44281.778591106835;44846.551534484235;44906.55093449024;44971.550284498044;45738;30367;31900.36199275955;31959.201019974687;32657.673423265463;32766.180845479055;30469.847650761603;32300.515492268103;32612.34775304528;32671.673283267814;32930.341393171526;33484.49773253354;34867.65132348644;35395.11512212215;35422.822885885405;35486.290274194886;29685.85157074287;31245;31886.84056579702;32022.519662205552;32273.193170170933;23289;23412.648810267518;23479.41301467477;23579.764202358445;23828.761712383348 15:49:56 INFO - PID 20344 | |2;jquery.html;565.9236003139578;568.9004424225759;576.5070864410928;584.2346526050873;595.943385378389;21014;22004;22050.558988820216;22057.448563785914;22431.55136897265;25463.61804572933;25891.352716182104;25949.481010379783;26120.608190877152;26167.607485887725;6290.905636415446;6431;6444.80665580031;6444.935550644481;6462.063000864871;5931.733072011748;6276.466500347476;6377.776777812777;6385.616862988236;6390.968045159768;6436.903446448307;6439.098526206335;6449.193850768654;6452.257990331102;6470.417662410382;6433.356664333576;6443.162388889461;6463.192100987377;6470.51471139664;6482.805515834532;5989.490893274077;6011.75952961881;6018.8194354169445;6020.127081573191;6024.728887200086;28381;29665.555016674767;30203.69796302031;30295.848520757474;30317.848410757804;1939.9903000484908;1977.3573588583768;1980.7127966444784;1983.9702404463944;1986.68213085907;18833.152508137166;19552.413427597196;19593.118309676098;19604.117814698373;19614.11736471848;2375.2992867104244;2386.618141097416;2432.2581612608146;2448.8163387745813;2458.754124587545;117981.23028154584;123957;124063.37968310191;124067;124669.37665311615;14308.213048282445;14548.418063277562;14555.563333100024;15272;15583.532494025198;22056.117755289928;23435.296941091794;23456.296311110695;23462.882685586465;23551.52896942086;10060.346077504939;10145.797084058426;10272.794544109225;10293.279470436997;10356.119729822898;9301.860472092923;9314.254859611216;9427.104425079606;9516.476593787409;9547.713568592953;9345.579448924815;9398.859017114748;9591.856122158173;9690.612375505041;9787;2431.33138386945;2451.705795304539;2465.4083020075054;2577.9226623201334;2612.9869350653125;918.205752024494;922.7416323429451;977.9706608801747;978.4814048554277;979.9759251582113;18895.338663146726;19278.13248403797;19383.224671013002;19504.31734889272;19864.304749333704;977.1254727019278;1003.5734812704571;1036.8237399641928;1039.293280569205;1047.4082143588848;10577.9471102644;11230.494627741607;12822.42299096543;14120.364583593762;14399.352029158503;469016;476101;481979;483967;484698;110554;116894;118307;122119.3894030542;122320;1239.8760123987709;1248.8001919692806;1299.9220046797222;1305.849827269857;1317.6903427694483;20239.696404554237;21138.471538211666;21367.465813354167;21714.457138571663;21850.235241766462;57549;58367;58628.4137158623;60018;60639;72137;74785.13037174114;75050.24949750432;75147;75979;14546.345414456586;14795;14812;14936.103833770008;15021;23700.88149559241;23822.88088559546;24067.879660601586;24107.63838542388;24108.397290067187;18471;18739.156737947098;18784.7182292263;19002.714959275898;19012.809871901656;16061.598460038593;16428.507144785675;17154.914225428794;17280.22238999273;17875.821241787417;18695.532611684815;19724.90137549303;19916.800831992074;19923.302684405975;19933.900330498254;14585.124892506483;14751;14859.554213373616;14876.851231487546;14884.7767283493;17825.821741782936;19075.80924190796;19196;19337;19365.61268774645 15:49:56 INFO - PID 20344 | |3;mootools.html;1331.9933400332998;1374.1342953939022;1378.7931810228458;1381.765099933011;1391.6033930329852;13169.736605267888;13562.254076025814;14116.788248176259;14232;14242.216678082714;13740.793888091686;14033.929830350833;14061.296935153252;14094.154350738963;14111.92944035281;2535.391506038551;2583.573710337792;2590.5855063189892;2592.118679648919;2592.1705054382605;2490.8131890108225;2554.552953233186;2573.0351118330627;2618.751218634227;2623.37039110614;2354.152505098163;2365.479594489218;2366;2375.5486457573006;2484.9751502485014;2383.833131680783;2392.1149174805346;2399.6160614301716;2417.7944874685672;2418.4195793009553;2230.676551899982;2242.461809165805;2242.5963326601204;2250.8874556272285;2256;13187.86812131876;13392.732145357135;13398.732025359535;13430.93284533571;13432.731345373038;6972.721091156348;7297.963510182468;7317.524360916524;7328.010718553034;7342.375898048672;4773.5226477352335;4779.784909679072;4851.393575803025;4949.505049495022;5041.294218809369;1780.4569606270084;1799.091458813304;1802.315120254308;1864.8321651051335;1867.8972656503886;21452;21547.138114475558;21599.028043738068;21607.675884861583;22635.886820565793;6045.909311360333;6288.930881750113;6328.493720502349;6332.240131184288;6342.587731797418;15582.922085389728;15597.376104955674;15633.062016278833;15640.843591564166;15652.843471565138;7327.194008659149;7374;7421.369183619345;7676.846463070708;7719.382449404035;6656.667166641649;6830.624315662587;6837.760678376233;6849.623270720158;6874.072000279998;4512.954870451319;4600.792964316547;4608.470025947059;4729.456112547101;4786.8085276589245;1235.6478403654914;1266.5123927287875;1271.3833790611545;1277.0422183362477;1283.2749496534427;857.4083882121316;857.498363457372;877.5480627476854;883.9955800220957;895.4492986813193;6659.567128136656;6984.511084224056;7044.682989265393;7076.4692648051605;7092.822679433056;703.1035429827011;718.3140101203338;725.6299287363482;743.605888878895;966.6036924860773;4611.608013318838;4811.975940120277;4864.765299467797;5076.0863044652315;5132.384113906355;17613.38353157659;17990.10049497546;18127.274909003754;18205.81794182068;18498.16758245882;17595.912020439817;18091;18117.275308987493;18177.63644727098;18370;9822.116009559173;10034.69895903124;10242.6415075472;10288.228382871315;10360.430176340373;7447;7661.923380766121;7834.921650783419;7887.881681774663;7976.8832363468;15523.844761552691;15856.207189640703;16184.919075404548;16211.918940405223;16315.918420407823;16138.919305403399;16216.918915405347;16312;16408.75386869174;16474.01155930648;9645.324827262024;9927.106560409598;9937.65218217359;9948.950255248677;9961.452120133463;12047.397630118283;12092.214006089576;12161.69595760113;12202.084843636585;12215.877841221829;9676.322657413913;10088.344257623232;10284.537195826355;10577.048065674126;10857.457127143769;9359.953200233955;9663.951680241555;9982.450965196984;10009.199264059003;10052.045055719695;8764.386492945432;9046.366754327397;9140.451572905647;9163.129502697233;9247.491387973727;6543.378379053982;6692.163479565054;6757.222919364336;6810.761623343159;6920.792376228721;7072.328128827753;7151.856962860609;7198.5680859148615;7314.37827784623;7327 15:49:56 INFO - PID 20344 | |4;prototype.html;492.39205993666485;493.714374571766;512.6795752654591;523.7669237189452;528.9656172348799;5874.647521148723;6056.515478761694;6121.540884433669;6151.3407664948245;6205.441510264075;5948.286205655317;5954.940450595493;6027.668478233706;6062.967736778474;6077.453029227379;5076.873078173038;5078.771455284521;5107.233914912774;5112.284280200774;5128.487151284879;5111.437741848394;5131.409887862887;5139.15203991341;5146.459621739719;5202.141646628302;4635.721856688592;4880.6095512358925;4903.224517121814;4915.434725006617;4937.185364414867;4875.341828853095;4922.655414121013;4924.975375123137;4928.7535623219055;4949.925751113737;4404.713693609905;4417.116576684676;4423.248047831844;4431.689781715281;4445.755188547212;5933.3473317934995;5955.076963070731;6024.427679370497;6058.727357268934;6073.726682299307;5614.691191984439;5625.749700119944;5691.288588926384;5696.943030569682;5711.200431939532;6311.392683341187;6352.237731472207;6382.978723404233;6477.449416799578;6507.967460162717;4789.568938795525;4811.350467686852;4811.879703007417;4840.806367745286;4849.951500484985;6655.367740064735;6771.796846094625;6815.045893574904;6833.838247497888;6872.41584465326;4925;4928.531789479994;4938.2839488274;4956.207006878882;4963.354763880672;4994.450610432849;4997.600191984705;5021.949780502221;5024.924626130611;5029.195328747456;5597;5599.272094627672;5641.294838145232;5649.322081350182;5673.489385955201;6322.585803666061;6336.809895703136;6469.385408386196;6515.012921059122;6595.604263744191;1622.6349071459063;1649.150687395992;1693.738165067033;1695.1863105709328;1741.773569435965;1208.7219939413983;1222.773786849418;1229.1457437081322;1232.4761976160096;1241.6771639373828;5525.530329921921;5560.944390556043;5604.8318550443555;5682.460166284196;5732.426757324318;6346.30190679025;6422.582532135396;6442.8389290268115;6562.5406221564035;6651.73393064272;5657.745401456944;5690.886182276331;5702.971485142548;5717.971410142923;5744.080947048452;3493.8078405687424;3512.297540491912;3528.6824185822884;3557.5019497270405;3583.677469027748;6409.807705768834;6439;6444.484441244689;6475;6482.611043337321;6778.694958726869;6816.829579260459;6821.386075253251;6877.58734475933;6910.965445172742;6393.6163830170335;6416.4225219729515;6447.6131432114225;6457.35248548093;6496.700659867951;6518.771842985473;6634.469242460688;6655.700493477708;6665.466762659073;6694.464442844658;6518.967405162944;6529.7388104475285;6610.338966103352;6632.336766323522;6655.267920528835;6317.178766760476;6345.714442850175;6479.8056058318325;6482.513811464065;6506.364922206325;4841.515848415272;4888.90222195547;4925.6305777066145;4929.728864912464;4930.383702037246;6583.67524400194;6616.735330586723;6617.702203400955;6633.64010377881;6659.433948114464;6338.605506788499;6400.967995160181;6409.679516024087;6413.326600706859;6444.581102228528;6302.3067462578165;6367.331430199948;6381.361863813767;6400.743970241138;6446.5165112615805;5850.18644220293;5944.554158438048;6245.594036387621;6283.434490895841;6386.201724784402;6238.719257633508;6268.247810262797;6287.339829317856;6295;6423.42189202974;6161.661108638888;6169.717204634135;6180.289266734383;6214.378562143749;6251.218597675291 15:49:56 INFO - PID 20344 | |5;yui.html;900.5722281916087;909.4452384045732;924.3344791749942;927.475976073518;929.5027160469147;15582;16352.75470867935;16368.18159092045;16368.263428145718;17193.484195474157;19653.803461965377;19752.604947901033;19825.206991720315;19859.602807943833;19865;991.3060857399813;1006.2654262388461;1007.0936157458273;1019.5106348952507;1019.775649357144;932.8647346134841;1026.497016461932;1033.3231733214718;1033.421284080917;1036.714903401563;1049.8425236214553;1100.2023532938636;1106.242224076506;1106.9778604427906;1107.5182295701356;1090.1823632275793;1091.110744743032;1092.847001419802;1096.353151640528;1102.5148934468807;789.2935822438885;798.4730078148452;801.3989507869098;801.5070731500143;803.8352137811735;17038.23327950233;17216.139193040424;17408.738868916975;17417.39039133624;17425.12874356277;18842.528936776554;19250.518737031547;19298.807011929843;19320.4203873884;19373.9031304844;16260.349586016546;16804.41184558547;16821.243044063045;16840.157992100467;16870;3597;3627.365211088049;3638.745287829853;3639.6906262967414;3639.872604458831;122483;124026.37986810098;128056;128642;130323.34838325843;15738.449154279546;15932.442364517417;16052.678946421007;16090.51728448125;16133.596660083593;28782.280442988675;29393;29445.411091778045;29571.556426653617;29741.702582973892;7525.962370188114;8283.95858020706;8679.392442528962;8680.56597170139;8697.695580654647;3389.847456864398;3945.171513982096;4164.2296175207075;4205.3902184183735;4206.537280899099;5068.138416469209;5099.745012749348;5135.922961155586;5168.819091331786;5192.221166824931;995.542050656706;1052.1214785653913;1065.4566171252718;1067.3649178738638;1072.7103682005816;674.2078058281597;676.9830754231184;686.3136863136863;710.6340234779093;711.8860982242817;12200.206986546023;12296.20074695142;12352.691182720504;12401.581691570238;12452.626421207378;675.7229535890261;696.0776970514089;699.6851416862432;705.3827900586987;707.3245050976408;5289.709066001406;5325.920111198335;5398.379186393537;5489.34127904654;5506.1190209566275;100008.4999575012;101048;102419.97580024254;102928.48535757273;107359.46320268504;87198;89986.68764371294;92174.53912730393;92687;96906.51546742221;77049;80604;80695.59652201702;81795.9999999988;84965.57517212375;10483.37099774016;10688.038076573146;11779.764404712028;12637;12713.11008229452;40228;41470.79264603658;41714.58285417107;44358;45806;74984.62507687426;78207.60896195483;78216.60891695732;80826.59586702028;83680;18152.72770908411;18731.1570979309;18882.905585471985;19220.903895480435;19688.90155549213;18300.90849545744;20713.27503537369;21368.7863121373;21369.57260854743;21401;18753.156107975447;18845.434636960912;19023.904880476064;19546.120424580644;19768.209271628974;19759.40721778349;19798.802011979697;20114.295999639944;20226.19095236233;20293.79706202919;18061.367852125113;18248.726269105708;18848.151833167816;18938;19083;13258.337083145998;13736.93131534336;13788.241646709528;14298.142111473346;14461.85538144605;10665.680029599125;10941.945290273497;12994.025448091243;13214.735705285648;13473.932630336785 15:49:56 INFO - PID 20344 | __end_tp_report 15:49:56 INFO - PID 20344 | __start_cc_report 15:49:56 INFO - PID 20344 | _x_x_mozilla_cycle_collect,359 15:49:56 INFO - PID 20344 | __end_cc_report 15:49:56 INFO - PID 20344 | __startTimestamp1500590996068__endTimestamp 15:49:56 INFO - PID 20344 | 15:49:56 INFO - PID 20344 | ------- Summary: start ------- 15:49:56 INFO - PID 20344 | Number of tests: 6 15:49:56 INFO - PID 20344 | 15:49:56 INFO - PID 20344 | [#0] dojo.html Cycles:165 Average:5961.36 Median:6204.19 stddev:694.75 (11.2%) stddev-sans-first:657.40 15:49:56 INFO - PID 20344 | Values: 3018.2 3070.1 3078.5 3101.3 3108.3 5950.9 5959.2 5983.0 6011.5 6103.3 6026.2 6079.0 6108.4 6133.1 6136.9 5408.6 5504.3 5510.8 5554.5 5624.5 5414.6 5492.7 5502.2 5576.7 5577.5 5501.9 5559.9 5573.2 5582.0 5591.6 5433.2 5491.6 5521.8 5562.7 5585.5 5434.9 5457.8 5519.8 5522.8 5533.3 5899.7 5938.8 5982.0 6011.4 6025.6 6341.5 6434.5 6443.7 6501.7 6519.9 6472.8 6504.6 6554.3 6555.0 6579.0 5982.6 5986.5 6057.9 6077.7 6078.1 6509.6 6567.2 6638.0 6670.2 6688.4 6288.2 6307.6 6308.7 6310.3 6315.0 6368.6 6495.2 6503.1 6529.8 6543.9 6409.9 6430.9 6454.7 6486.9 6489.7 6440.5 6445.3 6533.9 6540.2 6544.5 5146.2 5162.8 5219.3 5236.5 5243.5 4538.4 4547.3 4587.3 4587.8 4620.5 5598.4 5604.7 5610.0 5681.3 5686.9 6304.3 6461.8 6498.1 6514.4 6554.8 5592.0 5636.9 5642.5 5648.0 5651.7 5693.6 5739.9 5741.8 5770.6 5776.5 6157.9 6229.5 6244.8 6315.3 6331.7 6308.7 6458.3 6459.3 6550.0 6551.6 6312.6 6328.1 6330.8 6349.2 6365.6 6330.8 6362.6 6370.0 6449.8 6450.3 6420.1 6482.2 6501.3 6589.4 6596.8 6278.5 6289.7 6355.0 6357.4 6370.9 6259.7 6267.2 6342.0 6354.1 6356.8 6110.1 6171.1 6192.3 6204.2 6206.9 6290.1 6320.9 6360.8 6415.1 6418.4 6120.7 6138.3 6152.2 6235.8 6236.9 15:49:56 INFO - PID 20344 | 15:49:56 INFO - PID 20344 | [#1] ext.html Cycles:180 Average:37538.21 Median:35454.56 stddev:54315.75 (153.2%) stddev-sans-first:54397.99 15:49:56 INFO - PID 20344 | Values: 780.9 825.3 848.0 872.4 872.5 40088.6 41093.8 41111.4 41154.0 41217.8 36974.4 37344.0 37350.8 37535.6 37605.4 6789.9 6849.1 6889.8 6910.6 6911.9 6794.6 6878.6 6890.6 6894.2 6894.7 6861.7 7470.2 7637.0 7649.5 7658.2 7568.5 7620.9 7627.3 7628.7 7634.4 7456.7 7490.7 7546.4 7562.5 7568.0 37735.2 37889.4 37975.8 38224.0 38301.1 3553.2 3600.6 3613.2 3618.5 3621.6 30013.7 30032.2 30070.5 30119.5 30132.7 4902.6 4922.4 4950.8 4951.5 4980.8 189559.0 190404.0 191521.0 195843.0 205711.0 48623.0 48784.8 48825.3 48962.0 48979.0 49932.8 50359.5 50420.5 50424.7 50646.0 16198.7 16347.3 16374.5 16386.2 16505.3 13669.9 13682.6 13691.7 13702.5 13711.0 14243.4 14401.2 14421.6 14612.1 14630.1 5615.4 5713.1 5816.9 5846.9 5904.9 987.4 993.0 1007.9 1016.3 1026.8 22344.9 22553.8 22653.3 22959.0 23284.2 1082.9 1104.6 1110.9 1111.3 1131.9 11464.0 12089.0 12100.7 12155.7 12249.7 223341.0 224408.0 225386.0 225680.0 225939.0 52002.0 52131.7 52263.5 52319.0 52606.5 1458.7 1476.8 1494.7 1500.5 1505.8 22307.8 22418.7 22591.9 22940.7 23235.0 37599.6 37688.9 37792.1 37816.4 37819.0 192920.0 209391.0 211882.0 211952.0 213149.0 30556.7 30848.5 31117.7 33394.3 35737.1 44281.8 44846.6 44906.6 44971.6 45738.0 30367.0 31900.4 31959.2 32657.7 32766.2 30469.8 32300.5 32612.3 32671.7 32930.3 33484.5 34867.7 35395.1 35422.8 35486.3 29685.9 31245.0 31886.8 32022.5 32273.2 23289.0 23412.6 23479.4 23579.8 23828.8 15:49:56 INFO - PID 20344 | 15:49:56 INFO - PID 20344 | [#2] jquery.html Cycles:180 Average:34490.49 Median:23445.80 stddev:80500.91 (343.3%) stddev-sans-first:80686.44 15:49:56 INFO - PID 20344 | Values: 565.9 568.9 576.5 584.2 595.9 21014.0 22004.0 22050.6 22057.4 22431.6 25463.6 25891.4 25949.5 26120.6 26167.6 6290.9 6431.0 6444.8 6444.9 6462.1 5931.7 6276.5 6377.8 6385.6 6391.0 6436.9 6439.1 6449.2 6452.3 6470.4 6433.4 6443.2 6463.2 6470.5 6482.8 5989.5 6011.8 6018.8 6020.1 6024.7 28381.0 29665.6 30203.7 30295.8 30317.8 1940.0 1977.4 1980.7 1984.0 1986.7 18833.2 19552.4 19593.1 19604.1 19614.1 2375.3 2386.6 2432.3 2448.8 2458.8 117981.2 123957.0 124063.4 124067.0 124669.4 14308.2 14548.4 14555.6 15272.0 15583.5 22056.1 23435.3 23456.3 23462.9 23551.5 10060.3 10145.8 10272.8 10293.3 10356.1 9301.9 9314.3 9427.1 9516.5 9547.7 9345.6 9398.9 9591.9 9690.6 9787.0 2431.3 2451.7 2465.4 2577.9 2613.0 918.2 922.7 978.0 978.5 980.0 18895.3 19278.1 19383.2 19504.3 19864.3 977.1 1003.6 1036.8 1039.3 1047.4 10577.9 11230.5 12822.4 14120.4 14399.4 469016.0 476101.0 481979.0 483967.0 484698.0 110554.0 116894.0 118307.0 122119.4 122320.0 1239.9 1248.8 1299.9 1305.8 1317.7 20239.7 21138.5 21367.5 21714.5 21850.2 57549.0 58367.0 58628.4 60018.0 60639.0 72137.0 74785.1 75050.2 75147.0 75979.0 14546.3 14795.0 14812.0 14936.1 15021.0 23700.9 23822.9 24067.9 24107.6 24108.4 18471.0 18739.2 18784.7 19002.7 19012.8 16061.6 16428.5 17154.9 17280.2 17875.8 18695.5 19724.9 19916.8 19923.3 19933.9 14585.1 14751.0 14859.6 14876.9 14884.8 17825.8 19075.8 19196.0 19337.0 19365.6 15:49:56 INFO - PID 20344 | 15:49:56 INFO - PID 20344 | [#3] mootools.html Cycles:180 Average:8270.05 Median:2513.10 stddev:5646.67 (224.7%) stddev-sans-first:5638.45 15:49:56 INFO - PID 20344 | Values: 1332.0 1374.1 1378.8 1381.8 1391.6 13169.7 13562.3 14116.8 14232.0 14242.2 13740.8 14033.9 14061.3 14094.2 14111.9 2535.4 2583.6 2590.6 2592.1 2592.2 2490.8 2554.6 2573.0 2618.8 2623.4 2354.2 2365.5 2366.0 2375.5 2485.0 2383.8 2392.1 2399.6 2417.8 2418.4 2230.7 2242.5 2242.6 2250.9 2256.0 13187.9 13392.7 13398.7 13430.9 13432.7 6972.7 7298.0 7317.5 7328.0 7342.4 4773.5 4779.8 4851.4 4949.5 5041.3 1780.5 1799.1 1802.3 1864.8 1867.9 21452.0 21547.1 21599.0 21607.7 22635.9 6045.9 6288.9 6328.5 6332.2 6342.6 15582.9 15597.4 15633.1 15640.8 15652.8 7327.2 7374.0 7421.4 7676.8 7719.4 6656.7 6830.6 6837.8 6849.6 6874.1 4513.0 4600.8 4608.5 4729.5 4786.8 1235.6 1266.5 1271.4 1277.0 1283.3 857.4 857.5 877.5 884.0 895.4 6659.6 6984.5 7044.7 7076.5 7092.8 703.1 718.3 725.6 743.6 966.6 4611.6 4812.0 4864.8 5076.1 5132.4 17613.4 17990.1 18127.3 18205.8 18498.2 17595.9 18091.0 18117.3 18177.6 18370.0 9822.1 10034.7 10242.6 10288.2 10360.4 7447.0 7661.9 7834.9 7887.9 7976.9 15523.8 15856.2 16184.9 16211.9 16315.9 16138.9 16216.9 16312.0 16408.8 16474.0 9645.3 9927.1 9937.7 9949.0 9961.5 12047.4 12092.2 12161.7 12202.1 12215.9 9676.3 10088.3 10284.5 10577.0 10857.5 9360.0 9664.0 9982.5 10009.2 10052.0 8764.4 9046.4 9140.5 9163.1 9247.5 6543.4 6692.2 6757.2 6810.8 6920.8 7072.3 7151.9 7198.6 7314.4 7327.0 15:49:56 INFO - PID 20344 | 15:49:56 INFO - PID 20344 | [#4] prototype.html Cycles:180 Average:5426.77 Median:5955.01 stddev:1511.08 (25.4%) stddev-sans-first:1469.23 15:49:56 INFO - PID 20344 | Values: 492.4 493.7 512.7 523.8 529.0 5874.6 6056.5 6121.5 6151.3 6205.4 5948.3 5954.9 6027.7 6063.0 6077.5 5076.9 5078.8 5107.2 5112.3 5128.5 5111.4 5131.4 5139.2 5146.5 5202.1 4635.7 4880.6 4903.2 4915.4 4937.2 4875.3 4922.7 4925.0 4928.8 4949.9 4404.7 4417.1 4423.2 4431.7 4445.8 5933.3 5955.1 6024.4 6058.7 6073.7 5614.7 5625.7 5691.3 5696.9 5711.2 6311.4 6352.2 6383.0 6477.4 6508.0 4789.6 4811.4 4811.9 4840.8 4850.0 6655.4 6771.8 6815.0 6833.8 6872.4 4925.0 4928.5 4938.3 4956.2 4963.4 4994.5 4997.6 5021.9 5024.9 5029.2 5597.0 5599.3 5641.3 5649.3 5673.5 6322.6 6336.8 6469.4 6515.0 6595.6 1622.6 1649.2 1693.7 1695.2 1741.8 1208.7 1222.8 1229.1 1232.5 1241.7 5525.5 5560.9 5604.8 5682.5 5732.4 6346.3 6422.6 6442.8 6562.5 6651.7 5657.7 5690.9 5703.0 5718.0 5744.1 3493.8 3512.3 3528.7 3557.5 3583.7 6409.8 6439.0 6444.5 6475.0 6482.6 6778.7 6816.8 6821.4 6877.6 6911.0 6393.6 6416.4 6447.6 6457.4 6496.7 6518.8 6634.5 6655.7 6665.5 6694.5 6519.0 6529.7 6610.3 6632.3 6655.3 6317.2 6345.7 6479.8 6482.5 6506.4 4841.5 4888.9 4925.6 4929.7 4930.4 6583.7 6616.7 6617.7 6633.6 6659.4 6338.6 6401.0 6409.7 6413.3 6444.6 6302.3 6367.3 6381.4 6400.7 6446.5 5850.2 5944.6 6245.6 6283.4 6386.2 6238.7 6268.2 6287.3 6295.0 6423.4 6161.7 6169.7 6180.3 6214.4 6251.2 15:49:56 INFO - PID 20344 | 15:49:56 INFO - PID 20344 | [#5] yui.html Cycles:180 Average:23373.04 Median:19599.96 stddev:31491.49 (160.7%) stddev-sans-first:31534.62 15:49:56 INFO - PID 20344 | Values: 900.6 909.4 924.3 927.5 929.5 15582.0 16352.8 16368.2 16368.3 17193.5 19653.8 19752.6 19825.2 19859.6 19865.0 991.3 1006.3 1007.1 1019.5 1019.8 932.9 1026.5 1033.3 1033.4 1036.7 1049.8 1100.2 1106.2 1107.0 1107.5 1090.2 1091.1 1092.8 1096.4 1102.5 789.3 798.5 801.4 801.5 803.8 17038.2 17216.1 17408.7 17417.4 17425.1 18842.5 19250.5 19298.8 19320.4 19373.9 16260.3 16804.4 16821.2 16840.2 16870.0 3597.0 3627.4 3638.7 3639.7 3639.9 122483.0 124026.4 128056.0 128642.0 130323.3 15738.4 15932.4 16052.7 16090.5 16133.6 28782.3 29393.0 29445.4 29571.6 29741.7 7526.0 8284.0 8679.4 8680.6 8697.7 3389.8 3945.2 4164.2 4205.4 4206.5 5068.1 5099.7 5135.9 5168.8 5192.2 995.5 1052.1 1065.5 1067.4 1072.7 674.2 677.0 686.3 710.6 711.9 12200.2 12296.2 12352.7 12401.6 12452.6 675.7 696.1 699.7 705.4 707.3 5289.7 5325.9 5398.4 5489.3 5506.1 100008.5 101048.0 102420.0 102928.5 107359.5 87198.0 89986.7 92174.5 92687.0 96906.5 77049.0 80604.0 80695.6 81796.0 84965.6 10483.4 10688.0 11779.8 12637.0 12713.1 40228.0 41470.8 41714.6 44358.0 45806.0 74984.6 78207.6 78216.6 80826.6 83680.0 18152.7 18731.2 18882.9 19220.9 19688.9 18300.9 20713.3 21368.8 21369.6 21401.0 18753.2 18845.4 19023.9 19546.1 19768.2 19759.4 19798.8 20114.3 20226.2 20293.8 18061.4 18248.7 18848.2 18938.0 19083.0 13258.3 13736.9 13788.2 14298.1 14461.9 10665.7 10941.9 12994.0 13214.7 13473.9 15:49:56 INFO - PID 20344 | -------- Summary: end -------- 15:49:56 INFO - PID 20344 | 15:49:56 INFO - TEST-INFO | 20344: exit 0 15:49:56 INFO - TEST-OK | dromaeo_css | took 1113822ms 15:49:56 INFO - TEST-START | kraken 15:49:56 INFO - Initialising browser for kraken test... 15:49:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42924/getInfo.html -profile /tmp/tmpkDkBXt/profile 15:49:56 INFO - TEST-INFO | started process 20721 (/builds/slave/test/build/application/firefox/firefox http://localhost:42924/getInfo.html) 15:50:03 INFO - TEST-INFO | 20721: exit 0 15:50:03 INFO - Browser initialized. 15:50:03 INFO - Running cycle 1/1 for kraken test... 15:50:03 INFO - TEST-INFO | started process 20955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkDkBXt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:14 INFO - PID 20955 | RSS: Main: 175493120 15:50:14 INFO - PID 20955 | 15:50:17 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42924/tests/kraken/driver.html?testName=audio-beat-detection) 15:50:18 INFO - PID 20955 | RSS: Main: 179785728 15:50:18 INFO - PID 20955 | 15:50:20 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42924/tests/kraken/driver.html?testName=audio-dft) 15:50:21 INFO - PID 20955 | RSS: Main: 179965952 15:50:21 INFO - PID 20955 | 15:50:24 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42924/tests/kraken/driver.html?testName=audio-fft) 15:50:25 INFO - PID 20955 | RSS: Main: 174313472 15:50:25 INFO - PID 20955 | 15:50:27 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42924/tests/kraken/driver.html?testName=audio-oscillator) 15:50:27 INFO - PID 20955 | RSS: Main: 175460352 15:50:27 INFO - PID 20955 | 15:50:30 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42924/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:50:30 INFO - PID 20955 | RSS: Main: 175357952 15:50:30 INFO - PID 20955 | 15:50:33 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42924/tests/kraken/driver.html?testName=imaging-darkroom) 15:50:34 INFO - PID 20955 | RSS: Main: 177967104 15:50:34 INFO - PID 20955 | 15:50:37 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42924/tests/kraken/driver.html?testName=imaging-desaturate) 15:50:38 INFO - PID 20955 | RSS: Main: 177889280 15:50:38 INFO - PID 20955 | 15:50:41 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42924/tests/kraken/driver.html?testName=json-parse-financial) 15:50:42 INFO - PID 20955 | RSS: Main: 178438144 15:50:42 INFO - PID 20955 | 15:50:43 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42924/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:50:44 INFO - PID 20955 | RSS: Main: 178843648 15:50:44 INFO - PID 20955 | 15:50:46 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42924/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:50:46 INFO - PID 20955 | RSS: Main: 178364416 15:50:46 INFO - PID 20955 | 15:50:48 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42924/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:50:49 INFO - PID 20955 | RSS: Main: 178683904 15:50:49 INFO - PID 20955 | 15:50:52 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:50:53 INFO - PID 20955 | RSS: Main: 179187712 15:50:53 INFO - PID 20955 | 15:50:56 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:50:56 INFO - PID 20955 | RSS: Main: 179396608 15:50:56 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | Cycle 1(1): loaded http://localhost:42924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42924/tests/kraken/driver.html?testName=ai-astar) 15:50:58 INFO - PID 20955 | RSS: Main: 180908032 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | __start_tp_report 15:50:58 INFO - PID 20955 | _x_x_mozilla_page_load 15:50:58 INFO - PID 20955 | _x_x_mozilla_page_load_details 15:50:58 INFO - PID 20955 | |i|pagename|runs| 15:50:58 INFO - PID 20955 | |0;ai-astar;100;111;102;109;109;110;113;101;111;112 15:50:58 INFO - PID 20955 | |1;audio-beat-detection;152;118;153;168;120;147;155;125;177;126 15:50:58 INFO - PID 20955 | |2;audio-dft;164;163;164;162;162;163;164;165;167;164 15:50:58 INFO - PID 20955 | |3;audio-fft;77;75;75;176;75;76;77;74;158;78 15:50:58 INFO - PID 20955 | |4;audio-oscillator;80;82;151;81;81;81;128;80;80;126 15:50:58 INFO - PID 20955 | |5;imaging-gaussian-blur;118;114;114;114;114;115;116;117;114;115 15:50:58 INFO - PID 20955 | |6;imaging-darkroom;151;151;151;151;151;150;151;152;152;150 15:50:58 INFO - PID 20955 | |7;imaging-desaturate;94;94;95;94;95;99;94;96;95;95 15:50:58 INFO - PID 20955 | |8;json-parse-financial;53;57;55;55;53;56;58;54;53;55 15:50:58 INFO - PID 20955 | |9;json-stringify-tinderbox;56;54;55;54;55;54;56;59;59;55 15:50:58 INFO - PID 20955 | |10;stanford-crypto-aes;80;77;77;79;96;79;77;79;78;79 15:50:58 INFO - PID 20955 | |11;stanford-crypto-ccm;131;128;126;133;125;124;136;134;131;172 15:50:58 INFO - PID 20955 | |12;stanford-crypto-pbkdf2;180;177;178;173;192;181;176;175;177;180 15:50:58 INFO - PID 20955 | |13;stanford-crypto-sha256-iterative;71;77;68;68;73;69;72;69;68;69 15:50:58 INFO - PID 20955 | __end_tp_report 15:50:58 INFO - PID 20955 | __start_cc_report 15:50:58 INFO - PID 20955 | _x_x_mozilla_cycle_collect,978 15:50:58 INFO - PID 20955 | __end_cc_report 15:50:58 INFO - PID 20955 | __startTimestamp1500591058819__endTimestamp 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | ------- Summary: start ------- 15:50:58 INFO - PID 20955 | Number of tests: 14 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#0] ai-astar Cycles:10 Average:107.80 Median:110.50 stddev:4.87 (4.4%) stddev-sans-first:4.27 15:50:58 INFO - PID 20955 | Values: 100.0 111.0 102.0 109.0 109.0 110.0 113.0 101.0 111.0 112.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:152.50 stddev:20.75 (13.6%) stddev-sans-first:21.82 15:50:58 INFO - PID 20955 | Values: 152.0 118.0 153.0 168.0 120.0 147.0 155.0 125.0 177.0 126.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 15:50:58 INFO - PID 20955 | Values: 164.0 163.0 164.0 162.0 162.0 163.0 164.0 165.0 167.0 164.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:38.67 (51.2%) stddev-sans-first:40.52 15:50:58 INFO - PID 20955 | Values: 77.0 75.0 75.0 176.0 75.0 76.0 77.0 74.0 158.0 78.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:80.50 stddev:27.03 (33.6%) stddev-sans-first:27.97 15:50:58 INFO - PID 20955 | Values: 80.0 82.0 151.0 81.0 81.0 81.0 128.0 80.0 80.0 126.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.45 (1.3%) stddev-sans-first:1.09 15:50:58 INFO - PID 20955 | Values: 118.0 114.0 114.0 114.0 114.0 115.0 116.0 117.0 114.0 115.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 15:50:58 INFO - PID 20955 | Values: 151.0 151.0 151.0 151.0 151.0 150.0 151.0 152.0 152.0 150.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.52 (1.6%) stddev-sans-first:1.56 15:50:58 INFO - PID 20955 | Values: 94.0 94.0 95.0 94.0 95.0 99.0 94.0 96.0 95.0 95.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.73 (3.1%) stddev-sans-first:1.69 15:50:58 INFO - PID 20955 | Values: 53.0 57.0 55.0 55.0 53.0 56.0 58.0 54.0 53.0 55.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.50 stddev:1.89 (3.4%) stddev-sans-first:2.00 15:50:58 INFO - PID 20955 | Values: 56.0 54.0 55.0 54.0 55.0 54.0 56.0 59.0 59.0 55.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.00 stddev:5.69 (7.2%) stddev-sans-first:6.03 15:50:58 INFO - PID 20955 | Values: 80.0 77.0 77.0 79.0 96.0 79.0 77.0 79.0 78.0 79.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:132.00 stddev:13.94 (10.6%) stddev-sans-first:14.74 15:50:58 INFO - PID 20955 | Values: 131.0 128.0 126.0 133.0 125.0 124.0 136.0 134.0 131.0 172.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:179.00 stddev:5.22 (2.9%) stddev-sans-first:5.52 15:50:58 INFO - PID 20955 | Values: 180.0 177.0 178.0 173.0 192.0 181.0 176.0 175.0 177.0 180.0 15:50:58 INFO - PID 20955 | 15:50:58 INFO - PID 20955 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:2.91 (4.2%) stddev-sans-first:3.08 15:50:58 INFO - PID 20955 | Values: 71.0 77.0 68.0 68.0 73.0 69.0 72.0 69.0 68.0 69.0 15:50:58 INFO - PID 20955 | -------- Summary: end -------- 15:50:58 INFO - PID 20955 | 15:50:59 INFO - PID 20955 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:50:59 INFO - TEST-INFO | 20955: exit 0 15:50:59 INFO - TEST-OK | kraken | took 62792ms 15:50:59 INFO - SUITE-END | took 1176s 15:50:59 INFO - Completed test suite (00:19:36) 15:50:59 INFO - javascript benchmark 15:50:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8304.521146739675, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3018.185090025693, 3070.140360699004, 3078.492048811946, 3101.286704058067, 3108.254019035432, 5950.940490595092, 5959.165716799652, 5982.982892908205, 6011.519078473717, 6103.26760788706, 6026.2165918430655, 6078.969605151968, 6108.358622344656, 6133.1413602095745, 6136.938630613692, 5408.594355423339, 5504.311961004874, 5510.779568817243, 5554.472325129126, 5624.493795558399, 5414.648047876895, 5492.725363731797, 5502.174673798922, 5576.665400075988, 5577.52591029761, 5501.862453438676, 5559.916601250964, 5573.247611572447, 5582.023145949463, 5591.580631452616, 5433.212184233264, 5491.643043202219, 5521.834344969658, 5562.666240025612, 5585.469380408855, 5434.864128396782, 5457.808976685837, 5519.834404967857, 5522.806701765459, 5533.335999680024, 5899.675517846516, 5938.7624495020145, 5982.04287314032, 6011.4289142531825, 6025.638461692312, 6341.524385671093, 6434.549581529295, 6443.710033048524, 6501.707423165969, 6519.93480065198, 6472.773452929125, 6504.609723416563, 6554.3117972613145, 6554.967225163891, 6579.013148027786, 5982.641041537521, 5986.461218490357, 6057.909131362989, 6077.726502307407, 6078.057901025348, 6509.641969691713, 6567.244766851778, 6637.966810165918, 6670.232923213893, 6688.36460536258, 6288.213973253343, 6307.5584709070845, 6308.716107775161, 6310.337414571496, 6314.968425157845, 6368.554201205871, 6495.220573531206, 6503.122078519434, 6529.771457998947, 6543.901841472381, 6409.935900641027, 6430.935690643034, 6454.709538070798, 6486.870262594722, 6489.7404103835315, 6440.516961227833, 6445.2587952386075, 6533.869322613521, 6540.215174179129, 6544.476441884733, 5146.150885103991, 5162.767675454614, 5219.321488206585, 5236.528712415901, 5243.528082472596, 4538.387317712067, 4547.3179023146795, 4587.311903214544, 4587.839425620087, 4620.491745907947, 5598.384177740445, 5604.6917419542315, 5610.0, 5681.346645135863, 5686.943130568724, 6304.306526282106, 6461.773837915651, 6498.122753428322, 6514.4462720668325, 6554.8361290968105, 5591.9720401398545, 5636.887262254732, 5642.520385767256, 5648.0, 5651.660900345993, 5693.572982026281, 5739.885202295931, 5741.7990370337675, 5770.567207459458, 5776.480116789425, 6157.876842463036, 6229.501639868799, 6244.812655620339, 6315.305316415191, 6331.68341582919, 6308.684565771785, 6458.289588145394, 6459.321771213955, 6550.0, 6551.574147680385, 6312.621242725451, 6328.082428047999, 6330.8100756977365, 6349.238091429058, 6365.61806291624, 6330.8100756977365, 6362.554621176473, 6370.044493326038, 6449.806505804833, 6450.322716114741, 6420.133282006869, 6482.222133344029, 6501.317361676955, 6589.374009469285, 6596.80209593713, 6278.497720182466, 6289.7484100635465, 6355.0, 6357.396047375492, 6370.872582548416, 6259.718312676032, 6267.185265915402, 6342.0, 6354.142190804368, 6356.77751278703, 6110.1445797587485, 6171.074338849208, 6192.287886893065, 6204.193454850841, 6206.906896396648, 6290.119383286435, 6320.936790632219, 6360.77737279193, 6415.06981487691, 6418.358164183544, 6120.724567394389, 6138.294096178996, 6152.200213972155, 6235.75056997715, 6236.875262494816], "value": 5909.8959119039455, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.9375249979998, 825.3438516379478, 847.9660813567458, 872.3588162700418, 872.4765140915451, 40088.59911400885, 41093.79453102738, 41111.38332925005, 41154.0, 41217.7939110304, 36974.445383319275, 37344.0, 37350.8132459338, 37535.62464375355, 37605.43591846125, 6789.864202715955, 6849.07537482441, 6889.7588584399555, 6910.619915904624, 6911.861762764742, 6794.558353706993, 6878.587284762905, 6890.586564806128, 6894.24163342032, 6894.689738961733, 6861.691223894937, 7470.178280389153, 7636.961815190916, 7649.502782319159, 7658.234176582353, 7568.508046976929, 7620.885686714703, 7627.313541781211, 7628.694852205933, 7634.351080158193, 7456.701731930716, 7490.6629201686055, 7546.396288296923, 7562.470627056108, 7567.962160189164, 37735.24529509422, 37889.43165852514, 37975.810120949216, 38224.0, 38301.0849457526, 3553.1650062235353, 3600.5859326177565, 3613.2050948791225, 3618.5115009473648, 3621.619729928372, 30013.699863001308, 30032.24919377033, 30070.54894176589, 30119.548206776915, 30132.69867301321, 4902.632302577321, 4922.409310882681, 4950.777215025332, 4951.480094590052, 4980.750962451899, 189559.0, 190404.0, 191521.0, 195843.0, 205710.9714451433, 48623.0, 48784.7560762201, 48825.267620985716, 48962.0, 48979.0, 49932.750336248086, 50359.49640503621, 50420.49579504158, 50424.747876260386, 50646.0, 16198.676026479405, 16347.34610615562, 16374.508764737076, 16386.180690965404, 16505.33978640865, 13669.931650341685, 13682.589522314347, 13691.726165476834, 13702.52041178554, 13711.0, 14243.359048842827, 14401.207933563755, 14421.567352979428, 14612.123272603678, 14630.122192668474, 5615.354234263112, 5713.143028545752, 5816.883662326814, 5846.94153058464, 5904.852378690567, 987.4075554667143, 992.980140397188, 1007.9395236285847, 1016.3089099412323, 1026.753290684601, 22344.888275558842, 22553.77446225517, 22653.320400388016, 22958.96684649195, 23284.185053523044, 1082.929609575391, 1104.5802595014004, 1110.9388983605818, 1111.338753441717, 1131.8754936956927, 11464.0, 12089.0, 12100.700866835274, 12155.696107597381, 12249.69375765613, 223341.0, 224408.0, 225386.0, 225680.0, 225939.0, 52002.0, 52131.73934130305, 52263.47736522662, 52319.0, 52606.47393526016, 1458.6572155543438, 1476.8375478697335, 1494.7010597880467, 1500.4523348977546, 1505.8193016837831, 22307.77692223057, 22418.66372004454, 22591.887040564692, 22940.655890161994, 23235.0, 37599.624003759614, 37688.869333920025, 37792.055198620255, 37816.43275350817, 37819.0, 192920.0, 209391.0, 211882.0, 211952.0, 213149.0, 30556.694433056273, 30848.537271941386, 31117.688823112385, 33394.33211335808, 35737.1065723359, 44281.778591106835, 44846.551534484235, 44906.55093449024, 44971.550284498044, 45738.0, 30367.0, 31900.36199275955, 31959.201019974687, 32657.673423265463, 32766.180845479055, 30469.847650761603, 32300.515492268103, 32612.34775304528, 32671.673283267814, 32930.341393171526, 33484.49773253354, 34867.65132348644, 35395.11512212215, 35422.822885885405, 35486.290274194886, 29685.85157074287, 31245.0, 31886.84056579702, 32022.519662205552, 32273.193170170933, 23289.0, 23412.648810267518, 23479.41301467477, 23579.764202358445, 23828.761712383348], "value": 16938.59981273492, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9236003139578, 568.9004424225759, 576.5070864410928, 584.2346526050873, 595.943385378389, 21014.0, 22004.0, 22050.558988820216, 22057.448563785914, 22431.55136897265, 25463.61804572933, 25891.352716182104, 25949.481010379783, 26120.608190877152, 26167.607485887725, 6290.905636415446, 6431.0, 6444.80665580031, 6444.935550644481, 6462.063000864871, 5931.733072011748, 6276.466500347476, 6377.776777812777, 6385.616862988236, 6390.968045159768, 6436.903446448307, 6439.098526206335, 6449.193850768654, 6452.257990331102, 6470.417662410382, 6433.356664333576, 6443.162388889461, 6463.192100987377, 6470.51471139664, 6482.805515834532, 5989.490893274077, 6011.75952961881, 6018.8194354169445, 6020.127081573191, 6024.728887200086, 28381.0, 29665.555016674767, 30203.69796302031, 30295.848520757474, 30317.848410757804, 1939.9903000484908, 1977.3573588583768, 1980.7127966444784, 1983.9702404463944, 1986.68213085907, 18833.152508137166, 19552.413427597196, 19593.118309676098, 19604.117814698373, 19614.11736471848, 2375.2992867104244, 2386.618141097416, 2432.2581612608146, 2448.8163387745813, 2458.754124587545, 117981.23028154584, 123957.0, 124063.37968310191, 124067.0, 124669.37665311615, 14308.213048282445, 14548.418063277562, 14555.563333100024, 15272.0, 15583.532494025198, 22056.117755289928, 23435.296941091794, 23456.296311110695, 23462.882685586465, 23551.52896942086, 10060.346077504939, 10145.797084058426, 10272.794544109225, 10293.279470436997, 10356.119729822898, 9301.860472092923, 9314.254859611216, 9427.104425079606, 9516.476593787409, 9547.713568592953, 9345.579448924815, 9398.859017114748, 9591.856122158173, 9690.612375505041, 9787.0, 2431.33138386945, 2451.705795304539, 2465.4083020075054, 2577.9226623201334, 2612.9869350653125, 918.205752024494, 922.7416323429451, 977.9706608801747, 978.4814048554277, 979.9759251582113, 18895.338663146726, 19278.13248403797, 19383.224671013002, 19504.31734889272, 19864.304749333704, 977.1254727019278, 1003.5734812704571, 1036.8237399641928, 1039.293280569205, 1047.4082143588848, 10577.9471102644, 11230.494627741607, 12822.42299096543, 14120.364583593762, 14399.352029158503, 469016.0, 476101.0, 481979.0, 483967.0, 484698.0, 110554.0, 116894.0, 118307.0, 122119.3894030542, 122320.0, 1239.8760123987709, 1248.8001919692806, 1299.9220046797222, 1305.849827269857, 1317.6903427694483, 20239.696404554237, 21138.471538211666, 21367.465813354167, 21714.457138571663, 21850.235241766462, 57549.0, 58367.0, 58628.4137158623, 60018.0, 60639.0, 72137.0, 74785.13037174114, 75050.24949750432, 75147.0, 75979.0, 14546.345414456586, 14795.0, 14812.0, 14936.103833770008, 15021.0, 23700.88149559241, 23822.88088559546, 24067.879660601586, 24107.63838542388, 24108.397290067187, 18471.0, 18739.156737947098, 18784.7182292263, 19002.714959275898, 19012.809871901656, 16061.598460038593, 16428.507144785675, 17154.914225428794, 17280.22238999273, 17875.821241787417, 18695.532611684815, 19724.90137549303, 19916.800831992074, 19923.302684405975, 19933.900330498254, 14585.124892506483, 14751.0, 14859.554213373616, 14876.851231487546, 14884.7767283493, 17825.821741782936, 19075.80924190796, 19196.0, 19337.0, 19365.61268774645], "value": 12083.873067827395, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.9933400332998, 1374.1342953939022, 1378.7931810228458, 1381.765099933011, 1391.6033930329852, 13169.736605267888, 13562.254076025814, 14116.788248176259, 14232.0, 14242.216678082714, 13740.793888091686, 14033.929830350833, 14061.296935153252, 14094.154350738963, 14111.92944035281, 2535.391506038551, 2583.573710337792, 2590.5855063189892, 2592.118679648919, 2592.1705054382605, 2490.8131890108225, 2554.552953233186, 2573.0351118330627, 2618.751218634227, 2623.37039110614, 2354.152505098163, 2365.479594489218, 2366.0, 2375.5486457573006, 2484.9751502485014, 2383.833131680783, 2392.1149174805346, 2399.6160614301716, 2417.7944874685672, 2418.4195793009553, 2230.676551899982, 2242.461809165805, 2242.5963326601204, 2250.8874556272285, 2256.0, 13187.86812131876, 13392.732145357135, 13398.732025359535, 13430.93284533571, 13432.731345373038, 6972.721091156348, 7297.963510182468, 7317.524360916524, 7328.010718553034, 7342.375898048672, 4773.5226477352335, 4779.784909679072, 4851.393575803025, 4949.505049495022, 5041.294218809369, 1780.4569606270084, 1799.091458813304, 1802.315120254308, 1864.8321651051335, 1867.8972656503886, 21452.0, 21547.138114475558, 21599.028043738068, 21607.675884861583, 22635.886820565793, 6045.909311360333, 6288.930881750113, 6328.493720502349, 6332.240131184288, 6342.587731797418, 15582.922085389728, 15597.376104955674, 15633.062016278833, 15640.843591564166, 15652.843471565138, 7327.194008659149, 7374.0, 7421.369183619345, 7676.846463070708, 7719.382449404035, 6656.667166641649, 6830.624315662587, 6837.760678376233, 6849.623270720158, 6874.072000279998, 4512.954870451319, 4600.792964316547, 4608.470025947059, 4729.456112547101, 4786.8085276589245, 1235.6478403654914, 1266.5123927287875, 1271.3833790611545, 1277.0422183362477, 1283.2749496534427, 857.4083882121316, 857.498363457372, 877.5480627476854, 883.9955800220957, 895.4492986813193, 6659.567128136656, 6984.511084224056, 7044.682989265393, 7076.4692648051605, 7092.822679433056, 703.1035429827011, 718.3140101203338, 725.6299287363482, 743.605888878895, 966.6036924860773, 4611.608013318838, 4811.975940120277, 4864.765299467797, 5076.0863044652315, 5132.384113906355, 17613.38353157659, 17990.10049497546, 18127.274909003754, 18205.81794182068, 18498.16758245882, 17595.912020439817, 18091.0, 18117.275308987493, 18177.63644727098, 18370.0, 9822.116009559173, 10034.69895903124, 10242.6415075472, 10288.228382871315, 10360.430176340373, 7447.0, 7661.923380766121, 7834.921650783419, 7887.881681774663, 7976.8832363468, 15523.844761552691, 15856.207189640703, 16184.919075404548, 16211.918940405223, 16315.918420407823, 16138.919305403399, 16216.918915405347, 16312.0, 16408.75386869174, 16474.01155930648, 9645.324827262024, 9927.106560409598, 9937.65218217359, 9948.950255248677, 9961.452120133463, 12047.397630118283, 12092.214006089576, 12161.69595760113, 12202.084843636585, 12215.877841221829, 9676.322657413913, 10088.344257623232, 10284.537195826355, 10577.048065674126, 10857.457127143769, 9359.953200233955, 9663.951680241555, 9982.450965196984, 10009.199264059003, 10052.045055719695, 8764.386492945432, 9046.366754327397, 9140.451572905647, 9163.129502697233, 9247.491387973727, 6543.378379053982, 6692.163479565054, 6757.222919364336, 6810.761623343159, 6920.792376228721, 7072.328128827753, 7151.856962860609, 7198.5680859148615, 7314.37827784623, 7327.0], "value": 6002.640134940897, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.39205993666485, 493.714374571766, 512.6795752654591, 523.7669237189452, 528.9656172348799, 5874.647521148723, 6056.515478761694, 6121.540884433669, 6151.3407664948245, 6205.441510264075, 5948.286205655317, 5954.940450595493, 6027.668478233706, 6062.967736778474, 6077.453029227379, 5076.873078173038, 5078.771455284521, 5107.233914912774, 5112.284280200774, 5128.487151284879, 5111.437741848394, 5131.409887862887, 5139.15203991341, 5146.459621739719, 5202.141646628302, 4635.721856688592, 4880.6095512358925, 4903.224517121814, 4915.434725006617, 4937.185364414867, 4875.341828853095, 4922.655414121013, 4924.975375123137, 4928.7535623219055, 4949.925751113737, 4404.713693609905, 4417.116576684676, 4423.248047831844, 4431.689781715281, 4445.755188547212, 5933.3473317934995, 5955.076963070731, 6024.427679370497, 6058.727357268934, 6073.726682299307, 5614.691191984439, 5625.749700119944, 5691.288588926384, 5696.943030569682, 5711.200431939532, 6311.392683341187, 6352.237731472207, 6382.978723404233, 6477.449416799578, 6507.967460162717, 4789.568938795525, 4811.350467686852, 4811.879703007417, 4840.806367745286, 4849.951500484985, 6655.367740064735, 6771.796846094625, 6815.045893574904, 6833.838247497888, 6872.41584465326, 4925.0, 4928.531789479994, 4938.2839488274, 4956.207006878882, 4963.354763880672, 4994.450610432849, 4997.600191984705, 5021.949780502221, 5024.924626130611, 5029.195328747456, 5597.0, 5599.272094627672, 5641.294838145232, 5649.322081350182, 5673.489385955201, 6322.585803666061, 6336.809895703136, 6469.385408386196, 6515.012921059122, 6595.604263744191, 1622.6349071459063, 1649.150687395992, 1693.738165067033, 1695.1863105709328, 1741.773569435965, 1208.7219939413983, 1222.773786849418, 1229.1457437081322, 1232.4761976160096, 1241.6771639373828, 5525.530329921921, 5560.944390556043, 5604.8318550443555, 5682.460166284196, 5732.426757324318, 6346.30190679025, 6422.582532135396, 6442.8389290268115, 6562.5406221564035, 6651.73393064272, 5657.745401456944, 5690.886182276331, 5702.971485142548, 5717.971410142923, 5744.080947048452, 3493.8078405687424, 3512.297540491912, 3528.6824185822884, 3557.5019497270405, 3583.677469027748, 6409.807705768834, 6439.0, 6444.484441244689, 6475.0, 6482.611043337321, 6778.694958726869, 6816.829579260459, 6821.386075253251, 6877.58734475933, 6910.965445172742, 6393.6163830170335, 6416.4225219729515, 6447.6131432114225, 6457.35248548093, 6496.700659867951, 6518.771842985473, 6634.469242460688, 6655.700493477708, 6665.466762659073, 6694.464442844658, 6518.967405162944, 6529.7388104475285, 6610.338966103352, 6632.336766323522, 6655.267920528835, 6317.178766760476, 6345.714442850175, 6479.8056058318325, 6482.513811464065, 6506.364922206325, 4841.515848415272, 4888.90222195547, 4925.6305777066145, 4929.728864912464, 4930.383702037246, 6583.67524400194, 6616.735330586723, 6617.702203400955, 6633.64010377881, 6659.433948114464, 6338.605506788499, 6400.967995160181, 6409.679516024087, 6413.326600706859, 6444.581102228528, 6302.3067462578165, 6367.331430199948, 6381.361863813767, 6400.743970241138, 6446.5165112615805, 5850.18644220293, 5944.554158438048, 6245.594036387621, 6283.434490895841, 6386.201724784402, 6238.719257633508, 6268.247810262797, 6287.339829317856, 6295.0, 6423.42189202974, 6161.661108638888, 6169.717204634135, 6180.289266734383, 6214.378562143749, 6251.218597675291], "value": 4982.55066372796, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.5722281916087, 909.4452384045732, 924.3344791749942, 927.475976073518, 929.5027160469147, 15582.0, 16352.75470867935, 16368.18159092045, 16368.263428145718, 17193.484195474157, 19653.803461965377, 19752.604947901033, 19825.206991720315, 19859.602807943833, 19865.0, 991.3060857399813, 1006.2654262388461, 1007.0936157458273, 1019.5106348952507, 1019.775649357144, 932.8647346134841, 1026.497016461932, 1033.3231733214718, 1033.421284080917, 1036.714903401563, 1049.8425236214553, 1100.2023532938636, 1106.242224076506, 1106.9778604427906, 1107.5182295701356, 1090.1823632275793, 1091.110744743032, 1092.847001419802, 1096.353151640528, 1102.5148934468807, 789.2935822438885, 798.4730078148452, 801.3989507869098, 801.5070731500143, 803.8352137811735, 17038.23327950233, 17216.139193040424, 17408.738868916975, 17417.39039133624, 17425.12874356277, 18842.528936776554, 19250.518737031547, 19298.807011929843, 19320.4203873884, 19373.9031304844, 16260.349586016546, 16804.41184558547, 16821.243044063045, 16840.157992100467, 16870.0, 3597.0, 3627.365211088049, 3638.745287829853, 3639.6906262967414, 3639.872604458831, 122483.0, 124026.37986810098, 128056.0, 128642.0, 130323.34838325843, 15738.449154279546, 15932.442364517417, 16052.678946421007, 16090.51728448125, 16133.596660083593, 28782.280442988675, 29393.0, 29445.411091778045, 29571.556426653617, 29741.702582973892, 7525.962370188114, 8283.95858020706, 8679.392442528962, 8680.56597170139, 8697.695580654647, 3389.847456864398, 3945.171513982096, 4164.2296175207075, 4205.3902184183735, 4206.537280899099, 5068.138416469209, 5099.745012749348, 5135.922961155586, 5168.819091331786, 5192.221166824931, 995.542050656706, 1052.1214785653913, 1065.4566171252718, 1067.3649178738638, 1072.7103682005816, 674.2078058281597, 676.9830754231184, 686.3136863136863, 710.6340234779093, 711.8860982242817, 12200.206986546023, 12296.20074695142, 12352.691182720504, 12401.581691570238, 12452.626421207378, 675.7229535890261, 696.0776970514089, 699.6851416862432, 705.3827900586987, 707.3245050976408, 5289.709066001406, 5325.920111198335, 5398.379186393537, 5489.34127904654, 5506.1190209566275, 100008.4999575012, 101048.0, 102419.97580024254, 102928.48535757273, 107359.46320268504, 87198.0, 89986.68764371294, 92174.53912730393, 92687.0, 96906.51546742221, 77049.0, 80604.0, 80695.59652201702, 81795.9999999988, 84965.57517212375, 10483.37099774016, 10688.038076573146, 11779.764404712028, 12637.0, 12713.11008229452, 40228.0, 41470.79264603658, 41714.58285417107, 44358.0, 45806.0, 74984.62507687426, 78207.60896195483, 78216.60891695732, 80826.59586702028, 83680.0, 18152.72770908411, 18731.1570979309, 18882.905585471985, 19220.903895480435, 19688.90155549213, 18300.90849545744, 20713.27503537369, 21368.7863121373, 21369.57260854743, 21401.0, 18753.156107975447, 18845.434636960912, 19023.904880476064, 19546.120424580644, 19768.209271628974, 19759.40721778349, 19798.802011979697, 20114.295999639944, 20226.19095236233, 20293.79706202919, 18061.367852125113, 18248.726269105708, 18848.151833167816, 18938.0, 19083.0, 13258.337083145998, 13736.93131534336, 13788.241646709528, 14298.142111473346, 14461.85538144605, 10665.680029599125, 10941.945290273497, 12994.025448091243, 13214.735705285648, 13473.932630336785], "value": 9065.700061086249, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 102.0, 109.0, 109.0, 110.0, 113.0, 101.0, 111.0, 112.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 118.0, 153.0, 168.0, 120.0, 147.0, 155.0, 125.0, 177.0, 126.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 162.0, 162.0, 163.0, 164.0, 165.0, 167.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 176.0, 75.0, 76.0, 77.0, 74.0, 158.0, 78.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 151.0, 81.0, 81.0, 81.0, 128.0, 80.0, 80.0, 126.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 114.0, 114.0, 114.0, 115.0, 116.0, 117.0, 114.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 151.0, 151.0, 150.0, 151.0, 152.0, 152.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 99.0, 94.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 55.0, 55.0, 53.0, 56.0, 58.0, 54.0, 53.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 54.0, 55.0, 54.0, 56.0, 59.0, 59.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 77.0, 79.0, 96.0, 79.0, 77.0, 79.0, 78.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 128.0, 126.0, 133.0, 125.0, 124.0, 136.0, 134.0, 131.0, 172.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 177.0, 178.0, 173.0, 192.0, 181.0, 176.0, 175.0, 177.0, 180.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 77.0, 68.0, 68.0, 73.0, 69.0, 72.0, 69.0, 68.0, 69.0], "value": 70.4, "unit": "score"}]}]} 15:51:00 INFO - Return code: 0 15:51:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:51:00 INFO - # TBPL SUCCESS # 15:51:00 INFO - Running post-action listener: _package_coverage_data 15:51:00 INFO - Running post-action listener: _resource_record_post_action 15:51:00 INFO - [mozharness: 2017-07-20 22:51:00.103574Z] Finished run-tests step (success) 15:51:00 INFO - Running post-run listener: _resource_record_post_run 15:51:00 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436015104; Read time: 12; Write time: 396680 15:51:00 INFO - TinderboxPrint: CPU usage
13.2% 15:51:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:51:00 INFO - TinderboxPrint: I/O write bytes / time
436,015,104 / 396,680 15:51:00 INFO - TinderboxPrint: CPU idle
8,273.5 (86.8%) 15:51:00 INFO - TinderboxPrint: CPU user
1,201.7 (12.6%) 15:51:00 INFO - TinderboxPrint: Swap in / out
0 / 0 15:51:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106766336; Read time: 0; Write time: 127140 15:51:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:51:00 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 328126464; Read time: 0; Write time: 269512 15:51:00 INFO - Running post-run listener: _upload_blobber_files 15:51:00 INFO - Blob upload gear active. 15:51:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:51:00 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 15:51:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:51:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:51:01 INFO - (blobuploader) - INFO - Open directory for files ... 15:51:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:51:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:51:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:01 INFO - (blobuploader) - INFO - Done attempting. 15:51:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:51:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:51:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:05 INFO - (blobuploader) - INFO - Done attempting. 15:51:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:51:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:51:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:06 INFO - (blobuploader) - INFO - Done attempting. 15:51:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:51:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:51:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:06 INFO - (blobuploader) - INFO - Done attempting. 15:51:06 INFO - (blobuploader) - INFO - Iteration through files over. 15:51:06 INFO - Return code: 0 15:51:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:51:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:51:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8187fe8cc165f94f54ddbf56543bdc352da98f1c2e9d53125daac3ffc1202050af05464ef6dada8b6121f6c57af2d2b4ad84a00f0c477587125d02ef2061860", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62a82693521c40ff080167f2f87e8f651cd908577925ffc9c27a9c6493356e4bafff1bf188e1643675fbdb49b650a7e2091ecbd73f56bc7aa97a211d813fa3d3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5de81e0cb364b8febb1936760772a126f7a0911ae1ab7594742c04d3126d24a4fd19c546e7d550ae73ae5ac597255eda6ad140e44748ff6b64b7844ba5d6494", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b190481a666dc13fcbc2b6e28e4bcfae00e433d2698db26eb4936fe88ecec8d60ecc88651cddf6c25794591d281c11ec9ef3527219cf7f2509bd527940df4149"} 15:51:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:51:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:51:06 INFO - Contents: 15:51:06 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8187fe8cc165f94f54ddbf56543bdc352da98f1c2e9d53125daac3ffc1202050af05464ef6dada8b6121f6c57af2d2b4ad84a00f0c477587125d02ef2061860", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62a82693521c40ff080167f2f87e8f651cd908577925ffc9c27a9c6493356e4bafff1bf188e1643675fbdb49b650a7e2091ecbd73f56bc7aa97a211d813fa3d3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5de81e0cb364b8febb1936760772a126f7a0911ae1ab7594742c04d3126d24a4fd19c546e7d550ae73ae5ac597255eda6ad140e44748ff6b64b7844ba5d6494", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b190481a666dc13fcbc2b6e28e4bcfae00e433d2698db26eb4936fe88ecec8d60ecc88651cddf6c25794591d281c11ec9ef3527219cf7f2509bd527940df4149"} 15:51:06 INFO - Running post-run listener: copy_logs_to_upload_dir 15:51:06 INFO - Copying logs to upload dir... 15:51:06 INFO - mkdir: /builds/slave/test/build/upload/logs 15:51:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.706541 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-20 15:51:07.081247) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-20 15:51:07.083565) ========= 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=17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8187fe8cc165f94f54ddbf56543bdc352da98f1c2e9d53125daac3ffc1202050af05464ef6dada8b6121f6c57af2d2b4ad84a00f0c477587125d02ef2061860", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62a82693521c40ff080167f2f87e8f651cd908577925ffc9c27a9c6493356e4bafff1bf188e1643675fbdb49b650a7e2091ecbd73f56bc7aa97a211d813fa3d3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5de81e0cb364b8febb1936760772a126f7a0911ae1ab7594742c04d3126d24a4fd19c546e7d550ae73ae5ac597255eda6ad140e44748ff6b64b7844ba5d6494", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b190481a666dc13fcbc2b6e28e4bcfae00e433d2698db26eb4936fe88ecec8d60ecc88651cddf6c25794591d281c11ec9ef3527219cf7f2509bd527940df4149"} build_url:https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/ZpE3yDenSu-6dRoKsALlaQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8187fe8cc165f94f54ddbf56543bdc352da98f1c2e9d53125daac3ffc1202050af05464ef6dada8b6121f6c57af2d2b4ad84a00f0c477587125d02ef2061860", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62a82693521c40ff080167f2f87e8f651cd908577925ffc9c27a9c6493356e4bafff1bf188e1643675fbdb49b650a7e2091ecbd73f56bc7aa97a211d813fa3d3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5de81e0cb364b8febb1936760772a126f7a0911ae1ab7594742c04d3126d24a4fd19c546e7d550ae73ae5ac597255eda6ad140e44748ff6b64b7844ba5d6494", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b190481a666dc13fcbc2b6e28e4bcfae00e433d2698db26eb4936fe88ecec8d60ecc88651cddf6c25794591d281c11ec9ef3527219cf7f2509bd527940df4149"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-20 15:51:07.119408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 15:51:07.119813) ========= 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=17051fcd5208b27b50bedfeb000001dd-1500589690.213254-920959511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 15:51:07.194102) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-20 15:51:07.194427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-20 15:51:07.194733) ========= ========= Total master_lag: 0.43 =========